builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1475208659.85 results: success (0) buildid: 20160929183004 builduid: a6d1bfa101a84fcd9701b9566475bc43 revision: cdbfde37e79590e4c188ba854ab0b1612402e338 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 21:10:59.852092) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 21:10:59.853074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 21:10:59.853595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 21:10:59.884199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:10:59.884701) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 21:11:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-09-29 21:11:00 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:00.020062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:00.020410) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:00.070855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 21:11:00.071228) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cdbfde37e79590e4c188ba854ab0b1612402e338 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cdbfde37e79590e4c188ba854ab0b1612402e338 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 21:11:00,270 truncating revision to first 12 chars 2016-09-29 21:11:00,270 Setting DEBUG logging. 2016-09-29 21:11:00,270 attempt 1/10 2016-09-29 21:11:00,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cdbfde37e795?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 21:11:01,208 unpacking tar archive at: fx-team-cdbfde37e795/testing/mozharness/ program finished with exit code 0 elapsedTime=1.634245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 21:11:01.720445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:01.720802) ========= script_repo_revision: cdbfde37e79590e4c188ba854ab0b1612402e338 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:01.721224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:01.721513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 21:11:01.731311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-29 21:11:01.731751) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:11:02 INFO - MultiFileLogger online at 20160929 21:11:02 in /builds/slave/test 21:11:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:11:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:11:02 INFO - {'append_to_log': False, 21:11:02 INFO - 'base_work_dir': '/builds/slave/test', 21:11:02 INFO - 'blob_upload_branch': 'Fx-Team', 21:11:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:11:02 INFO - 'branch': 'Fx-Team', 21:11:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:11:02 INFO - 'config_files': ('talos/linux_config.py',), 21:11:02 INFO - 'default_actions': ('clobber', 21:11:02 INFO - 'read-buildbot-config', 21:11:02 INFO - 'download-and-extract', 21:11:02 INFO - 'populate-webroot', 21:11:02 INFO - 'create-virtualenv', 21:11:02 INFO - 'install', 21:11:02 INFO - 'run-tests'), 21:11:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:11:02 INFO - 'download_minidump_stackwalk': True, 21:11:02 INFO - 'download_symbols': 'ondemand', 21:11:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:11:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:11:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:11:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:11:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:11:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:11:02 INFO - 'installer_path': 'installer.exe', 21:11:02 INFO - 'log_level': 'info', 21:11:02 INFO - 'log_name': 'talos', 21:11:02 INFO - 'log_to_console': True, 21:11:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:11:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:11:02 INFO - 'opt_config_files': (), 21:11:02 INFO - 'pip_index': False, 21:11:02 INFO - 'sps_profile': False, 21:11:02 INFO - 'sps_profile_interval': 0, 21:11:02 INFO - 'suite': 'dromaeojs', 21:11:02 INFO - 'system_bits': '32', 21:11:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:11:02 INFO - 'title': 'talos-linux64-ix-015', 21:11:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:11:02 INFO - 'use_talos_json': True, 21:11:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:11:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:11:02 INFO - 'work_dir': 'build'} 21:11:02 INFO - [mozharness: 2016-09-30 04:11:02.028269Z] Running clobber step. 21:11:02 INFO - Running pre-action listener: _resource_record_pre_action 21:11:02 INFO - Running main action method: clobber 21:11:02 INFO - rmtree: /builds/slave/test/build 21:11:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:11:03 INFO - Running post-action listener: _resource_record_post_action 21:11:03 INFO - [mozharness: 2016-09-30 04:11:03.005903Z] Finished clobber step (success) 21:11:03 INFO - [mozharness: 2016-09-30 04:11:03.006004Z] Running read-buildbot-config step. 21:11:03 INFO - Running pre-action listener: _resource_record_pre_action 21:11:03 INFO - Running main action method: read_buildbot_config 21:11:03 INFO - Using buildbot properties: 21:11:03 INFO - { 21:11:03 INFO - "project": "", 21:11:03 INFO - "product": "firefox", 21:11:03 INFO - "script_repo_revision": "production", 21:11:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:11:03 INFO - "repository": "", 21:11:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:11:03 INFO - "buildid": "20160929183004", 21:11:03 INFO - "pgo_build": "True", 21:11:03 INFO - "basedir": "/builds/slave/test", 21:11:03 INFO - "buildnumber": 490, 21:11:03 INFO - "slavename": "talos-linux64-ix-015", 21:11:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:11:03 INFO - "platform": "ubuntu64_hw", 21:11:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:11:03 INFO - "branch": "fx-team", 21:11:03 INFO - "repo_path": "integration/fx-team", 21:11:03 INFO - "revision": "cdbfde37e79590e4c188ba854ab0b1612402e338", 21:11:03 INFO - "stage_platform": "linux64-pgo", 21:11:03 INFO - "builduid": "a6d1bfa101a84fcd9701b9566475bc43", 21:11:03 INFO - "slavebuilddir": "test" 21:11:03 INFO - } 21:11:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:11:03 INFO - Running post-action listener: _resource_record_post_action 21:11:03 INFO - [mozharness: 2016-09-30 04:11:03.008478Z] Finished read-buildbot-config step (success) 21:11:03 INFO - [mozharness: 2016-09-30 04:11:03.008568Z] Running download-and-extract step. 21:11:03 INFO - Running pre-action listener: _resource_record_pre_action 21:11:03 INFO - Running main action method: download_and_extract 21:11:03 INFO - mkdir: /builds/slave/test/build/tests 21:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:03 INFO - trying https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:11:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:11:03 INFO - Downloaded 1361 bytes. 21:11:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:11:03 INFO - Using the following test package requirements: 21:11:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:11:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:11:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:11:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'jsshell-linux-x86_64.zip'], 21:11:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:11:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:11:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:11:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:11:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:11:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:11:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:11:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:11:04 INFO - Http code: 200 21:11:04 INFO - Content-Encoding: None 21:11:04 INFO - Content-Type: application/zip 21:11:04 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 21:11:04 INFO - x-amz-cf-id: QHOSzj8NdSTpJzEkSK8eS9H53sCnH5Q8BNnNywiN_TyIEiENPeWzbw== 21:11:04 INFO - x-amz-version-id: POgcDL9ipaa_Kk13eeXxLIkEGRI5S1HS 21:11:04 INFO - x-cache: Hit from cloudfront 21:11:04 INFO - Expected file size: 21988995 21:11:04 INFO - Obtained file size: 21988995 21:11:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:11:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:11:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:11:08 INFO - Fetch https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:11:09 INFO - Http code: 200 21:11:09 INFO - Content-Encoding: None 21:11:09 INFO - Content-Type: application/zip 21:11:09 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 21:11:09 INFO - x-amz-cf-id: ZAv6-vKAXUgA7dMLRvKEtLfSovUaEnY1n3UyCFgtnWxuZPtB386_tw== 21:11:09 INFO - x-amz-version-id: POgcDL9ipaa_Kk13eeXxLIkEGRI5S1HS 21:11:09 INFO - x-cache: Hit from cloudfront 21:11:09 INFO - Expected file size: 21988995 21:11:09 INFO - Obtained file size: 21988995 21:11:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:11:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:11:13 INFO - Fetch https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:11:14 INFO - Http code: 200 21:11:14 INFO - Content-Encoding: None 21:11:14 INFO - Content-Type: application/zip 21:11:14 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 21:11:14 INFO - x-amz-cf-id: DpSVOVa3lUKh-jmx4vYpZe0FqZ-HFD8lTPRdenN_lL_R9y-uJZYAXw== 21:11:14 INFO - x-amz-version-id: nUzYfMCTVL_QC9LgBZnZEK_eJXsozYZP 21:11:14 INFO - x-cache: Hit from cloudfront 21:11:14 INFO - Expected file size: 14414067 21:11:14 INFO - Obtained file size: 14414067 21:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:14 INFO - trying https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:11:14 INFO - Downloading https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:11:16 INFO - Downloaded 59685753 bytes. 21:11:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:11:16 INFO - mkdir: /builds/slave/test/properties 21:11:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:11:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:11:16 INFO - Contents: 21:11:16 INFO - build_url:https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:11:17 INFO - Running post-action listener: _resource_record_post_action 21:11:17 INFO - Running post-action listener: set_extra_try_arguments 21:11:17 INFO - [mozharness: 2016-09-30 04:11:17.307161Z] Finished download-and-extract step (success) 21:11:17 INFO - [mozharness: 2016-09-30 04:11:17.307388Z] Running populate-webroot step. 21:11:17 INFO - Running pre-action listener: _resource_record_pre_action 21:11:17 INFO - Running main action method: populate_webroot 21:11:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:11:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:11:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:11:17 INFO - '--tppagecycles', 21:11:17 INFO - '7'], 21:11:17 INFO - 'tests': ['tsvgm']}}, 21:11:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:11:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:11:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:11:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:11:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['damp', 'tps']}, 21:11:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'tests': ['damp', 'tps']}, 21:11:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['dromaeo_dom']}, 21:11:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:11:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['basic_compositor_video']}, 21:11:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:11:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'other-e10s': {'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['a11yr', 21:11:17 INFO - 'ts_paint', 21:11:17 INFO - 'tpaint', 21:11:17 INFO - 'sessionrestore', 21:11:17 INFO - 'sessionrestore_no_auto_restore', 21:11:17 INFO - 'tabpaint']}, 21:11:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['tsvgx', 21:11:17 INFO - 'tsvgr_opacity', 21:11:17 INFO - 'tart', 21:11:17 INFO - 'tscrollx', 21:11:17 INFO - 'cart']}, 21:11:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:11:17 INFO - 'tsvgr_opacity', 21:11:17 INFO - 'tart', 21:11:17 INFO - 'tscrollx', 21:11:17 INFO - 'cart']}, 21:11:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'talos_options': ['--disable-e10s'], 21:11:17 INFO - 'tests': ['tp5o']}, 21:11:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'tests': ['tp5o']}, 21:11:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'talos_options': ['--disable-e10s', 21:11:17 INFO - '--xperf_path', 21:11:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:17 INFO - 'tests': ['tp5n']}, 21:11:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:11:17 INFO - 'talos_options': ['--xperf_path', 21:11:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:17 INFO - 'tests': ['tp5n']}}, 21:11:17 INFO - 'talos.zip': {'path': '', 21:11:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:11:17 INFO - Running post-action listener: _resource_record_post_action 21:11:17 INFO - [mozharness: 2016-09-30 04:11:17.324494Z] Finished populate-webroot step (success) 21:11:17 INFO - [mozharness: 2016-09-30 04:11:17.324582Z] Running create-virtualenv step. 21:11:17 INFO - Running pre-action listener: _resource_record_pre_action 21:11:17 INFO - Running main action method: create_virtualenv 21:11:17 INFO - Creating virtualenv /builds/slave/test/build/venv 21:11:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:11:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:11:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:11:17 INFO - Using real prefix '/usr' 21:11:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:11:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:11:19 INFO - Installing pip.................done. 21:11:19 INFO - Return code: 0 21:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:11:20 INFO - Reading from file tmpfile_stdout 21:11:20 INFO - Output received: 21:11:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:11:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:11:20 INFO - Using env: {'DISPLAY': ':0', 21:11:20 INFO - 'HOME': '/home/cltbld', 21:11:20 INFO - 'LANG': 'en_US.UTF-8', 21:11:20 INFO - 'LANGUAGE': 'en_US:en', 21:11:20 INFO - 'LOGNAME': 'cltbld', 21:11:20 INFO - 'MAIL': '/var/mail/cltbld', 21:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:20 INFO - 'MOZ_NO_REMOTE': '1', 21:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:20 INFO - 'NO_EM_RESTART': '1', 21:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:20 INFO - 'PWD': '/builds/slave/test', 21:11:20 INFO - 'SHELL': '/bin/bash', 21:11:20 INFO - 'SHLVL': '1', 21:11:20 INFO - 'TERM': 'linux', 21:11:20 INFO - 'TMOUT': '86400', 21:11:20 INFO - 'USER': 'cltbld', 21:11:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:20 INFO - '_': '/tools/buildbot/bin/python'} 21:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:11:20 INFO - Cleaning up... 21:11:20 INFO - Return code: 0 21:11:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:11:20 INFO - Using env: {'DISPLAY': ':0', 21:11:20 INFO - 'HOME': '/home/cltbld', 21:11:20 INFO - 'LANG': 'en_US.UTF-8', 21:11:20 INFO - 'LANGUAGE': 'en_US:en', 21:11:20 INFO - 'LOGNAME': 'cltbld', 21:11:20 INFO - 'MAIL': '/var/mail/cltbld', 21:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:20 INFO - 'MOZ_NO_REMOTE': '1', 21:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:20 INFO - 'NO_EM_RESTART': '1', 21:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:20 INFO - 'PWD': '/builds/slave/test', 21:11:20 INFO - 'SHELL': '/bin/bash', 21:11:20 INFO - 'SHLVL': '1', 21:11:20 INFO - 'TERM': 'linux', 21:11:20 INFO - 'TMOUT': '86400', 21:11:20 INFO - 'USER': 'cltbld', 21:11:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:20 INFO - '_': '/tools/buildbot/bin/python'} 21:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:20 INFO - Downloading/unpacking psutil>=3.1.1 21:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:11:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:22 INFO - Installing collected packages: psutil 21:11:22 INFO - Running setup.py install for psutil 21:11:22 INFO - building 'psutil._psutil_linux' extension 21:11:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:11:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:11:22 INFO - building 'psutil._psutil_posix' extension 21:11:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:11:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:11:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:23 INFO - Successfully installed psutil 21:11:23 INFO - Cleaning up... 21:11:23 INFO - Return code: 0 21:11:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:11:23 INFO - Using env: {'DISPLAY': ':0', 21:11:23 INFO - 'HOME': '/home/cltbld', 21:11:23 INFO - 'LANG': 'en_US.UTF-8', 21:11:23 INFO - 'LANGUAGE': 'en_US:en', 21:11:23 INFO - 'LOGNAME': 'cltbld', 21:11:23 INFO - 'MAIL': '/var/mail/cltbld', 21:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:23 INFO - 'MOZ_NO_REMOTE': '1', 21:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:23 INFO - 'NO_EM_RESTART': '1', 21:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:23 INFO - 'PWD': '/builds/slave/test', 21:11:23 INFO - 'SHELL': '/bin/bash', 21:11:23 INFO - 'SHLVL': '1', 21:11:23 INFO - 'TERM': 'linux', 21:11:23 INFO - 'TMOUT': '86400', 21:11:23 INFO - 'USER': 'cltbld', 21:11:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:23 INFO - '_': '/tools/buildbot/bin/python'} 21:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:11:25 INFO - Installing collected packages: mozsystemmonitor 21:11:25 INFO - Running setup.py install for mozsystemmonitor 21:11:25 INFO - Successfully installed mozsystemmonitor 21:11:25 INFO - Cleaning up... 21:11:25 INFO - Return code: 0 21:11:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:11:25 INFO - Using env: {'DISPLAY': ':0', 21:11:25 INFO - 'HOME': '/home/cltbld', 21:11:25 INFO - 'LANG': 'en_US.UTF-8', 21:11:25 INFO - 'LANGUAGE': 'en_US:en', 21:11:25 INFO - 'LOGNAME': 'cltbld', 21:11:25 INFO - 'MAIL': '/var/mail/cltbld', 21:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:25 INFO - 'MOZ_NO_REMOTE': '1', 21:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:25 INFO - 'NO_EM_RESTART': '1', 21:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:25 INFO - 'PWD': '/builds/slave/test', 21:11:25 INFO - 'SHELL': '/bin/bash', 21:11:25 INFO - 'SHLVL': '1', 21:11:25 INFO - 'TERM': 'linux', 21:11:25 INFO - 'TMOUT': '86400', 21:11:25 INFO - 'USER': 'cltbld', 21:11:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:25 INFO - '_': '/tools/buildbot/bin/python'} 21:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:11:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:11:27 INFO - warning: no files found matching '*.txt' 21:11:27 INFO - no previously-included directories found matching 'build' 21:11:27 INFO - no previously-included directories found matching 'dist' 21:11:27 INFO - no previously-included directories found matching '.git*' 21:11:27 INFO - Installing collected packages: jsonschema, functools32 21:11:27 INFO - Running setup.py install for functools32 21:11:27 INFO - warning: no files found matching '*.txt' 21:11:27 INFO - no previously-included directories found matching 'build' 21:11:27 INFO - no previously-included directories found matching 'dist' 21:11:27 INFO - no previously-included directories found matching '.git*' 21:11:27 INFO - Successfully installed jsonschema functools32 21:11:27 INFO - Cleaning up... 21:11:27 INFO - Return code: 0 21:11:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:11:27 INFO - Using env: {'DISPLAY': ':0', 21:11:27 INFO - 'HOME': '/home/cltbld', 21:11:27 INFO - 'LANG': 'en_US.UTF-8', 21:11:27 INFO - 'LANGUAGE': 'en_US:en', 21:11:27 INFO - 'LOGNAME': 'cltbld', 21:11:27 INFO - 'MAIL': '/var/mail/cltbld', 21:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:27 INFO - 'MOZ_NO_REMOTE': '1', 21:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:28 INFO - 'NO_EM_RESTART': '1', 21:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:28 INFO - 'PWD': '/builds/slave/test', 21:11:28 INFO - 'SHELL': '/bin/bash', 21:11:28 INFO - 'SHLVL': '1', 21:11:28 INFO - 'TERM': 'linux', 21:11:28 INFO - 'TMOUT': '86400', 21:11:28 INFO - 'USER': 'cltbld', 21:11:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:28 INFO - '_': '/tools/buildbot/bin/python'} 21:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:11:28 INFO - Cleaning up... 21:11:28 INFO - Return code: 0 21:11:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:11:28 INFO - Using env: {'DISPLAY': ':0', 21:11:28 INFO - 'HOME': '/home/cltbld', 21:11:28 INFO - 'LANG': 'en_US.UTF-8', 21:11:28 INFO - 'LANGUAGE': 'en_US:en', 21:11:28 INFO - 'LOGNAME': 'cltbld', 21:11:28 INFO - 'MAIL': '/var/mail/cltbld', 21:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:28 INFO - 'MOZ_NO_REMOTE': '1', 21:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:28 INFO - 'NO_EM_RESTART': '1', 21:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:28 INFO - 'PWD': '/builds/slave/test', 21:11:28 INFO - 'SHELL': '/bin/bash', 21:11:28 INFO - 'SHLVL': '1', 21:11:28 INFO - 'TERM': 'linux', 21:11:28 INFO - 'TMOUT': '86400', 21:11:28 INFO - 'USER': 'cltbld', 21:11:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:28 INFO - '_': '/tools/buildbot/bin/python'} 21:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:28 INFO - Downloading/unpacking blobuploader==1.2.4 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:30 INFO - Downloading blobuploader-1.2.4.tar.gz 21:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:11:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:11:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:30 INFO - Downloading docopt-0.6.1.tar.gz 21:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:11:31 INFO - Installing collected packages: blobuploader, requests, docopt 21:11:31 INFO - Running setup.py install for blobuploader 21:11:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:11:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:11:31 INFO - Running setup.py install for requests 21:11:31 INFO - Running setup.py install for docopt 21:11:31 INFO - Successfully installed blobuploader requests docopt 21:11:31 INFO - Cleaning up... 21:11:31 INFO - Return code: 0 21:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:31 INFO - Using env: {'DISPLAY': ':0', 21:11:31 INFO - 'HOME': '/home/cltbld', 21:11:31 INFO - 'LANG': 'en_US.UTF-8', 21:11:31 INFO - 'LANGUAGE': 'en_US:en', 21:11:31 INFO - 'LOGNAME': 'cltbld', 21:11:31 INFO - 'MAIL': '/var/mail/cltbld', 21:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:31 INFO - 'MOZ_NO_REMOTE': '1', 21:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:31 INFO - 'NO_EM_RESTART': '1', 21:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:31 INFO - 'PWD': '/builds/slave/test', 21:11:31 INFO - 'SHELL': '/bin/bash', 21:11:31 INFO - 'SHLVL': '1', 21:11:31 INFO - 'TERM': 'linux', 21:11:31 INFO - 'TMOUT': '86400', 21:11:31 INFO - 'USER': 'cltbld', 21:11:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:31 INFO - '_': '/tools/buildbot/bin/python'} 21:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:31 INFO - Running setup.py (path:/tmp/pip-_A8E16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:31 INFO - Running setup.py (path:/tmp/pip-CcJKrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:32 INFO - Running setup.py (path:/tmp/pip-MdXHVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:32 INFO - Running setup.py (path:/tmp/pip-RQscZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:32 INFO - Running setup.py (path:/tmp/pip-UzQbuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:32 INFO - Running setup.py (path:/tmp/pip-GArATz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:32 INFO - Running setup.py (path:/tmp/pip-ANoWpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:32 INFO - Running setup.py (path:/tmp/pip-wqVvkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:32 INFO - Running setup.py (path:/tmp/pip-HiKY4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:32 INFO - Running setup.py (path:/tmp/pip-mW6zTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:32 INFO - Running setup.py (path:/tmp/pip-t6oDKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:32 INFO - Running setup.py (path:/tmp/pip-4ezs_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:32 INFO - Running setup.py (path:/tmp/pip-6i1Zm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:32 INFO - Running setup.py (path:/tmp/pip-zpReQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:32 INFO - Running setup.py (path:/tmp/pip-l6M9QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:32 INFO - Running setup.py (path:/tmp/pip-OUnn08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:33 INFO - Running setup.py (path:/tmp/pip-8xVwUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:11:33 INFO - Running setup.py install for manifestparser 21:11:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Running setup.py install for mozcrash 21:11:33 INFO - Running setup.py install for mozdebug 21:11:33 INFO - Running setup.py install for mozdevice 21:11:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Running setup.py install for mozfile 21:11:33 INFO - Running setup.py install for mozhttpd 21:11:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Running setup.py install for mozinfo 21:11:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Running setup.py install for mozInstall 21:11:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:11:33 INFO - Running setup.py install for mozleak 21:11:34 INFO - Running setup.py install for mozlog 21:11:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Running setup.py install for moznetwork 21:11:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Running setup.py install for mozprocess 21:11:34 INFO - Running setup.py install for mozprofile 21:11:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Running setup.py install for mozrunner 21:11:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Running setup.py install for mozscreenshot 21:11:34 INFO - Running setup.py install for moztest 21:11:34 INFO - Running setup.py install for mozversion 21:11:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:11:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:11:34 INFO - Cleaning up... 21:11:34 INFO - Return code: 0 21:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:34 INFO - Using env: {'DISPLAY': ':0', 21:11:34 INFO - 'HOME': '/home/cltbld', 21:11:34 INFO - 'LANG': 'en_US.UTF-8', 21:11:34 INFO - 'LANGUAGE': 'en_US:en', 21:11:34 INFO - 'LOGNAME': 'cltbld', 21:11:34 INFO - 'MAIL': '/var/mail/cltbld', 21:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:34 INFO - 'MOZ_NO_REMOTE': '1', 21:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:34 INFO - 'NO_EM_RESTART': '1', 21:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:34 INFO - 'PWD': '/builds/slave/test', 21:11:34 INFO - 'SHELL': '/bin/bash', 21:11:34 INFO - 'SHLVL': '1', 21:11:34 INFO - 'TERM': 'linux', 21:11:34 INFO - 'TMOUT': '86400', 21:11:34 INFO - 'USER': 'cltbld', 21:11:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:34 INFO - '_': '/tools/buildbot/bin/python'} 21:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:35 INFO - Running setup.py (path:/tmp/pip-cfQ0YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:35 INFO - Running setup.py (path:/tmp/pip-T0TsHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:35 INFO - Running setup.py (path:/tmp/pip-r5WuH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:35 INFO - Running setup.py (path:/tmp/pip-HPpA32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:35 INFO - Running setup.py (path:/tmp/pip-mxTWkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:35 INFO - Running setup.py (path:/tmp/pip-xKOlBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:35 INFO - Running setup.py (path:/tmp/pip-0vJaOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:35 INFO - Running setup.py (path:/tmp/pip-IkyKAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:35 INFO - Running setup.py (path:/tmp/pip-VMUBPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:35 INFO - Running setup.py (path:/tmp/pip-JJg3wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:35 INFO - Running setup.py (path:/tmp/pip-KFDJFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:35 INFO - Running setup.py (path:/tmp/pip-OSCUOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:36 INFO - Running setup.py (path:/tmp/pip-QHm66H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:36 INFO - Running setup.py (path:/tmp/pip-Somu5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:36 INFO - Running setup.py (path:/tmp/pip-vlIv2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:36 INFO - Running setup.py (path:/tmp/pip-GQ4lBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:36 INFO - Running setup.py (path:/tmp/pip-1etJLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:38 INFO - Downloading blessings-1.6.tar.gz 21:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:11:38 INFO - Installing collected packages: blessings 21:11:38 INFO - Running setup.py install for blessings 21:11:38 INFO - Successfully installed blessings 21:11:38 INFO - Cleaning up... 21:11:38 INFO - Return code: 0 21:11:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:38 INFO - Reading from file tmpfile_stdout 21:11:38 INFO - Current package versions: 21:11:38 INFO - argparse == 1.2.1 21:11:38 INFO - blessings == 1.6 21:11:38 INFO - blobuploader == 1.2.4 21:11:38 INFO - docopt == 0.6.1 21:11:38 INFO - functools32 == 3.2.3-2 21:11:38 INFO - jsonschema == 2.5.1 21:11:38 INFO - manifestparser == 1.1 21:11:38 INFO - mozInstall == 1.12 21:11:38 INFO - mozcrash == 0.17 21:11:38 INFO - mozdebug == 0.1 21:11:38 INFO - mozdevice == 0.48 21:11:38 INFO - mozfile == 1.2 21:11:38 INFO - mozhttpd == 0.7 21:11:38 INFO - mozinfo == 0.9 21:11:38 INFO - mozleak == 0.1 21:11:38 INFO - mozlog == 3.4 21:11:38 INFO - moznetwork == 0.27 21:11:38 INFO - mozprocess == 0.23 21:11:38 INFO - mozprofile == 0.28 21:11:38 INFO - mozrunner == 6.12 21:11:38 INFO - mozscreenshot == 0.1 21:11:38 INFO - mozsystemmonitor == 0.3 21:11:38 INFO - moztest == 0.7 21:11:38 INFO - mozversion == 1.4 21:11:38 INFO - psutil == 3.1.1 21:11:38 INFO - requests == 1.2.3 21:11:38 INFO - wsgiref == 0.1.2 21:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:38 INFO - Using env: {'DISPLAY': ':0', 21:11:38 INFO - 'HOME': '/home/cltbld', 21:11:38 INFO - 'LANG': 'en_US.UTF-8', 21:11:38 INFO - 'LANGUAGE': 'en_US:en', 21:11:38 INFO - 'LOGNAME': 'cltbld', 21:11:38 INFO - 'MAIL': '/var/mail/cltbld', 21:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:38 INFO - 'MOZ_NO_REMOTE': '1', 21:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:38 INFO - 'NO_EM_RESTART': '1', 21:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:38 INFO - 'PWD': '/builds/slave/test', 21:11:38 INFO - 'SHELL': '/bin/bash', 21:11:38 INFO - 'SHLVL': '1', 21:11:38 INFO - 'TERM': 'linux', 21:11:38 INFO - 'TMOUT': '86400', 21:11:38 INFO - 'USER': 'cltbld', 21:11:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:38 INFO - '_': '/tools/buildbot/bin/python'} 21:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:11:38 INFO - Cleaning up... 21:11:39 INFO - Return code: 0 21:11:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f097b7a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:11:39 INFO - Using env: {'DISPLAY': ':0', 21:11:39 INFO - 'HOME': '/home/cltbld', 21:11:39 INFO - 'LANG': 'en_US.UTF-8', 21:11:39 INFO - 'LANGUAGE': 'en_US:en', 21:11:39 INFO - 'LOGNAME': 'cltbld', 21:11:39 INFO - 'MAIL': '/var/mail/cltbld', 21:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:39 INFO - 'MOZ_NO_REMOTE': '1', 21:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:39 INFO - 'NO_EM_RESTART': '1', 21:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:39 INFO - 'PWD': '/builds/slave/test', 21:11:39 INFO - 'SHELL': '/bin/bash', 21:11:39 INFO - 'SHLVL': '1', 21:11:39 INFO - 'TERM': 'linux', 21:11:39 INFO - 'TMOUT': '86400', 21:11:39 INFO - 'USER': 'cltbld', 21:11:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:39 INFO - '_': '/tools/buildbot/bin/python'} 21:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:11:39 INFO - Cleaning up... 21:11:39 INFO - Return code: 0 21:11:39 INFO - Running post-action listener: _resource_record_post_action 21:11:39 INFO - Running post-action listener: _start_resource_monitoring 21:11:39 INFO - Starting resource monitoring. 21:11:39 INFO - [mozharness: 2016-09-30 04:11:39.279074Z] Finished create-virtualenv step (success) 21:11:39 INFO - [mozharness: 2016-09-30 04:11:39.279539Z] Running install step. 21:11:39 INFO - Running pre-action listener: _resource_record_pre_action 21:11:39 INFO - Running main action method: install 21:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:39 INFO - Reading from file tmpfile_stdout 21:11:39 INFO - Detecting whether we're running mozinstall >=1.0... 21:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:11:39 INFO - Reading from file tmpfile_stdout 21:11:39 INFO - Output received: 21:11:39 INFO - Usage: mozinstall [options] installer 21:11:39 INFO - Options: 21:11:39 INFO - -h, --help show this help message and exit 21:11:39 INFO - -d DEST, --destination=DEST 21:11:39 INFO - Directory to install application into. [default: 21:11:39 INFO - "/builds/slave/test"] 21:11:39 INFO - --app=APP Application being installed. [default: firefox] 21:11:39 INFO - mkdir: /builds/slave/test/build/application 21:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:11:57 INFO - Reading from file tmpfile_stdout 21:11:57 INFO - Output received: 21:11:57 INFO - /builds/slave/test/build/application/firefox/firefox 21:11:57 INFO - Running post-action listener: _resource_record_post_action 21:11:57 INFO - [mozharness: 2016-09-30 04:11:57.130473Z] Finished install step (success) 21:11:57 INFO - [mozharness: 2016-09-30 04:11:57.130719Z] Running run-tests step. 21:11:57 INFO - Running pre-action listener: _resource_record_pre_action 21:11:57 INFO - Running main action method: run_tests 21:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:11:57 INFO - Python 2.7.3 21:11:57 INFO - Return code: 0 21:11:57 INFO - grabbing minidump binary from tooltool 21:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:11:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:11:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:11:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:11:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:57 INFO - Return code: 0 21:11:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:11:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:11:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:11:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:11:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:11:57 INFO - Using env: {'DISPLAY': ':0', 21:11:57 INFO - 'HOME': '/home/cltbld', 21:11:57 INFO - 'LANG': 'en_US.UTF-8', 21:11:57 INFO - 'LANGUAGE': 'en_US:en', 21:11:57 INFO - 'LOGNAME': 'cltbld', 21:11:57 INFO - 'MAIL': '/var/mail/cltbld', 21:11:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:11:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:57 INFO - 'MOZ_NO_REMOTE': '1', 21:11:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:57 INFO - 'NO_EM_RESTART': '1', 21:11:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:57 INFO - 'PWD': '/builds/slave/test', 21:11:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:11:57 INFO - 'SHELL': '/bin/bash', 21:11:57 INFO - 'SHLVL': '1', 21:11:57 INFO - 'TERM': 'linux', 21:11:57 INFO - 'TMOUT': '86400', 21:11:57 INFO - 'USER': 'cltbld', 21:11:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834', 21:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:57 INFO - '_': '/tools/buildbot/bin/python'} 21:11:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:11:57 INFO - mozversion application_buildid: 20160929183004 21:11:57 INFO - mozversion application_changeset: cdbfde37e79590e4c188ba854ab0b1612402e338 21:11:57 INFO - mozversion application_display_name: Nightly 21:11:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:57 INFO - mozversion application_name: Firefox 21:11:57 INFO - mozversion application_remotingname: firefox 21:11:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:11:57 INFO - mozversion application_vendor: Mozilla 21:11:57 INFO - mozversion application_version: 52.0a1 21:11:57 INFO - mozversion platform_buildid: 20160929183004 21:11:57 INFO - mozversion platform_changeset: cdbfde37e79590e4c188ba854ab0b1612402e338 21:11:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:11:57 INFO - mozversion platform_version: 52.0a1 21:11:57 INFO - using testdate: 1475208717 21:11:57 INFO - actual date: 1475208717 21:11:57 INFO - starting webserver on 'localhost:46681' 21:11:57 INFO - SUITE-START | Running 2 tests 21:11:57 INFO - TEST-START | dromaeo_css 21:11:57 INFO - operating with platform_type : linux_ 21:11:57 INFO - Initialising browser for dromaeo_css test... 21:11:57 INFO - TEST-INFO | started process 9957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0N83J/profile http://localhost:46681/getInfo.html) 21:12:01 INFO - PROCESS | 9957 | __metrics Screen width/height:1600/1200 21:12:01 INFO - PROCESS | 9957 | colorDepth:24 21:12:01 INFO - PROCESS | 9957 | Browser inner width/height: 1024/697 21:12:01 INFO - PROCESS | 9957 | __metrics 21:12:02 INFO - PROCESS | 9957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:12:02 INFO - PROCESS | 9957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:12:02 INFO - PROCESS | 9957 | console.error: PushService: 21:12:02 INFO - PROCESS | 9957 | stateChangeProcessEnqueue: Error transitioning state 21:12:02 INFO - PROCESS | 9957 | UnknownError 21:12:03 INFO - TEST-INFO | 9957: exit 0 21:12:03 INFO - Browser initialized. 21:12:03 INFO - Running cycle 1/1 for dromaeo_css test... 21:12:03 INFO - TEST-INFO | started process 10042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0N83J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:12:15 INFO - PROCESS | 10042 | RSS: Main: 177303552 21:12:15 INFO - PROCESS | 10042 | 21:13:06 INFO - PROCESS | 10042 | 1475208786743 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:15:16 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46681/tests/dromaeo/cssquery-ext.html) 21:15:17 INFO - PROCESS | 10042 | RSS: Main: 317186048 21:15:17 INFO - PROCESS | 10042 | 21:18:19 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-ext.html (next: http://localhost:46681/tests/dromaeo/cssquery-jquery.html) 21:18:20 INFO - PROCESS | 10042 | RSS: Main: 266301440 21:18:20 INFO - PROCESS | 10042 | 21:21:22 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46681/tests/dromaeo/cssquery-mootools.html) 21:21:23 INFO - PROCESS | 10042 | RSS: Main: 216952832 21:21:23 INFO - PROCESS | 10042 | 21:24:25 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46681/tests/dromaeo/cssquery-prototype.html) 21:24:25 INFO - PROCESS | 10042 | RSS: Main: 214654976 21:24:25 INFO - PROCESS | 10042 | 21:27:28 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46681/tests/dromaeo/cssquery-yui.html) 21:27:29 INFO - PROCESS | 10042 | RSS: Main: 215724032 21:27:29 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-yui.html (next: http://localhost:46681/tests/dromaeo/cssquery-dojo.html) 21:30:32 INFO - PROCESS | 10042 | RSS: Main: 307630080 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | __start_tp_report 21:30:32 INFO - PROCESS | 10042 | _x_x_mozilla_page_load 21:30:32 INFO - PROCESS | 10042 | _x_x_mozilla_page_load_details 21:30:32 INFO - PROCESS | 10042 | |i|pagename|runs| 21:30:32 INFO - PROCESS | 10042 | |0;dojo.html;2975.8363290019047;3004.984975075125;3005.5040918248505;3032.6664066952644;3051.8779248830047;5200.323957885479;5272.103742363798;5337.733113344332;5413.26920865683;5419.512243898049;5273.709945952981;5348.277982472365;5405.810796622119;5418.2685337479425;5532.944670553294;4832.0335932813405;4854.223324268118;4882.511748825107;4914.459409464956;4942.579880710144;4935.555799978001;4978.2532620107095;5007.273945277932;5035.219540971137;5084.491550844923;4965.453800081988;4980.576650984671;5010.974945125269;5025;5069.417017043051;4744.976275118637;4774.307725379836;4844.806207751686;4892.559669629751;4918.336024636664;4785.736784476852;4792.952070479286;4796.44840843304;4801.615870730333;4859.95140048602;5299.231611416361;5374.731263436852;5386.3536375634785;5394.298741163663;5394.757235924393;5580.358258800209;5613.158026296048;5675.9432405675825;5749.367569567345;5765.827025189251;5722.055860783007;5722.484976352148;5786.797462088806;5837.387074357216;5859.267591551056;5381.973090134525;5386.649867758583;5389.191621256843;5390.460953904618;5391.73041347931;5749.223854779635;5780.421957804186;5918.644881307136;5920.4967577755515;5929.140274660236;5587.217789509472;5619.213310136584;5621.578381621313;5634.6337488063145;5697.914531282034;5704.543636509069;5716.228309178291;5717.971410142923;5720.1991721159075;5720.399358067426;5529.612927095065;5633.57748168889;5678.403767604342;5679.574031947621;5693.430656934356;5571.1086226203615;5619.578531610146;5645.435456454404;5650.7739690412745;5703.800366987219;4356.956430435655;4359.607635312837;4360.280553708666;4366.912661746811;4423.270160423558;3878.4376265441915;3894.4937158169255;3898.90252743678;3939.881803545898;3948.3485224937563;5270.78916843322;5314.096603577401;5381.865453363697;5424.810131645373;5437.972810135924;5751.051076572318;5751.654900705971;5753.971230143822;5768.2501274834;5820;5363.410024897258;5437.755301011464;5441.319835020622;5442.292501974718;5443.537299329601;4772.141014617402;4804.183288840905;4807.399075115611;4894.3147959285725;4993.251012348177;5957.880842383128;5985.970070149621;5996.430339117776;6057.091436284504;6064.4541991221;5728.742206600797;5771.624844385102;5788.652680839163;5790.478856902899;5796.101604251347;5815.4184581543195;5842;5882.94117058841;5998.4601385875485;6009.399060093956;5556.666600004012;5585.581081418991;5611.523020543136;5646.040173170653;5655;5636.3799982002765;5637.830865074055;5639.548836093185;5645.887082258249;5684.516816070515;5414.512693857571;5457.317835270591;5485.369182544058;5537.169424586345;5537.529310008695;5568.248286481273;5589.748461319332;5591.133374326986;5614.2701448811395;5678.6876721779045;5557.916631250615;5558.833235002957;5562.443755624567;5563.721813909369;5572.219889215432;5504.504594586507;5583.0787919992745;5601.607887448003;5655.830325090254;5659.462351076641;5382.919256211082;5392.05639013179;5394.487523685244;5420.728963551728;5496.7526461308535 21:30:32 INFO - PROCESS | 10042 | |1;ext.html;576.3285772075532;603.0772917436323;626.4205609810926;631.6241836107516;638.1608185236411;34665.99999999997;35414.46878296827;35455.82272088639;35466.64533354662;43053.784731076375;42047.579524204746;46254;46309.30536041962;46311.76844115775;46318.76840615792;8900.554972251377;9020.548972551345;9051.185393314601;9064.18422341989;9065.410748301372;8048.356131509495;8221.054578723433;8886.644534218623;10613.522391492363;10891.618793342235;11022.173336999756;11103.944480277587;11110.666679999573;11110.666679999613;11114.11087113029;10882.61910833121;10979.945100274528;10988.945055274753;11012.229143959967;11013.339199648046;8005.159458256858;8213.917860821435;10307.587696492206;10587.417692026935;10608.469576521144;41988.580114198776;42355.57644423547;42394;42397.57602423998;42411;3475.6176820549717;3572.517710109128;3731.8693845715543;3832.3676593362343;3913.236918800835;31307.37385252305;31727.84136079305;32144.839275803704;32177.839110804296;32215.355692886013;4264.978675106605;4360.847370342023;4380.3371093148935;4431.889202769924;4456.398386217851;388856;389225.05387473165;392527;393575;395206;56723.43276567264;56869.14696279559;57197.71401143051;57250.41243813461;57273.42726572681;60193.39806601878;60302.396976029675;60332.39667603355;60341.69829150914;60462.09306860401;15363;15884.602884927737;15901.284442200129;15904.363825447084;15911.443099491693;10882.836757448644;12155.817662735066;12390.81413778794;12394.504219831286;12402.937985310016;13931.721365572632;15455.227238638023;15955.760663590056;16036.278367473491;16498;5973.611715238582;6093.542984276197;6216.502679785606;6228.252609686867;6261.624302541771;936.8173206224857;953.2374100719396;1038.050184081572;1085.8696956365286;1094.5452010317929;29151;30734.846325768227;31142.532862007087;31437.214069648442;31558.808767771407;1044.6657069737762;1091.82530795074;1137.2323681514945;1153.221575436577;1184.0645889747004;15996.200189990454;16373.508794736177;16409.42567010149;16502.42241521541;16734.414295499842;536716;537173;537408;540307;540883;50272.49727502751;51145.23282150771;55679.164812527844;56840;57877;1304.8956083513297;1310.1418570836117;1316.4273541009884;1332.6934804994712;1333.8599447057918;30537.847310763304;32632;32925.67074329226;33158.17104572309;33435.66564334326;52287.21569176389;52686.736566316926;52966;53005.7349713249;53052.46947530475;472107;493445;494310;770382;775187;27745.722542774314;27877.721222788325;28054.85972570124;28147.279036700667;28454.288642783267;47051;47601.52398475971;47960;48042.5195748038;48295.27557086717;40103.19793604053;40117;40366.59633403629;42067.57932420759;42225.577744222166;39447.21105577815;40439.595604043585;40460.59539404568;41882;41970.790146049076;40211.396829047;40990.5653302133;41462.378064328455;41499;41500;33418.33163336671;35824.46263306105;36455.635443645224;36746.63253367432;36951;27615.30961725973;27886.721132789226;27904.860475697493;27912.44175116527;28025.71974280231 21:30:32 INFO - PROCESS | 10042 | |2;jquery.html;377.724261289259;390.1884081111287;396.6271704597678;401.7208040411915;417.73056378635783;13458.865411345883;15496.690066198684;16697.415590454337;19284.517887052796;19548;19272.229110835586;19866.900665496687;19918.800811991874;19937.40187794365;19945;5760.683162426076;5765.077587585987;5943.108533719955;5980.581359304851;5998.160257563923;5857.326407463153;5872.354041055481;5897.941020589804;5904.321003084658;5945.821625351246;5571.6378435401775;5797.739101740411;5811.418858114197;5852.12218167274;5868.972929737279;5771.394003629601;5820.883582328351;5848.2689663792025;5864.179014937912;5886.558508111866;5185.481451854822;5266.789328426858;5271.393789714193;5421.105517589593;5465.672059676433;13932.721345573033;14124.788128178085;14167.220802855838;14283.21442320672;14380.209088500129;2329.592321343758;2414.022320960014;2857.22854829197;2881.063654312336;2896.174590241792;11905.404729763564;13375.464981400732;14180.50368237117;14202.289885505787;14566.344514496874;1894.4506093232947;1894.5168981909662;1915.9329423470112;1937;1980.9702854457194;80103;82218;82412.58793706053;82968.58515707383;86454.99999999937;10994.560217591206;11165.38590377537;11241.494132764044;11262.493187806569;11358.432078396212;15830;15860.841391585936;15864.286107125206;15890.443834465737;15896.841031589767;7320.780376588605;7923.12845586985;7973.681052757941;8004.959975200203;8101.918980810235;7405.407567394595;7555.471117021865;7657.367292787783;7750.302472777477;7766.689332426639;4722.811087556459;4769.093872164347;4786.569208771228;4800.303955926371;4940.975295123501;1893.7064754963003;2000.7499062617173;2030.319842852661;2034.010005292218;2081.4172031831113;926.2219735422277;929.972100836976;939.1641439119189;950.5674917912334;964.7973925475728;18267.63464730698;19299.131539080776;19355.612887742165;19365.12856921442;19574.70637940432;957.3920560444029;970.7233438470143;988.658912675126;995.7361299255703;1057.2652006855162;9772.462514561767;10587.57649694019;10651.147908167328;10680.359178449318;10751.731206719738;440128;481055;481327;482390.46852423454;490784;94719;96279.51860240794;100342;101107.49446252722;101861.49069254607;993.6373223773271;1021.4994652620163;1069.9518521666544;1070.4808168038496;1073.4847273308699;16657.250423731202;16871.325146994473;17081.572960676083;17417.12914354252;17917.910410447865;38928.41607375948;40767;42204.366934495396;43572.34641480317;44557;57926.13110803426;57954.494323039246;58157;58990;60540.69729651324;5332.813351532678;5937.406259374028;7869.190086280073;8468;8594.441361311494;12295.508179672714;12852.164609300366;12999.415026324028;13037.804432933324;13166.210027398387;6607;10723.624673136403;10945.945270273916;11341.546338146713;12134.514619415124;11063.502142403771;11206.607768728056;11439.14206434504;11586.71033224176;12233.938830305791;9202.619607058994;12028.939855301018;12031.398430078636;12409.75180496367;12545;8362.163783621832;8427.325813934993;8438.282745966662;8895.955520222617;8923.598438070172;11425.828612570653;11520.13598980063;11617.419129043345;11637.185397022127;12049.397530123284 21:30:32 INFO - PROCESS | 10042 | |3;mootools.html;1330.7405056014081;1475.3950880139141;1499.490173341064;1651.2816924637784;1765.691004074286;7384.889226661598;8594.87107693385;8866.86699699505;8869.37914345996;9126.178643922045;8784.341174411913;8819.735407937773;8834.514101724402;8854.86717699235;8862;2312.7224733032017;2346.683197768305;2358.445765245166;2365.597848365773;2378.0844374915696;2289.9885500572473;2308.503671710582;2383.6901202843605;2387.486690361572;2388.3312672451652;2319.8724070176136;2322.547103314846;2333.7316208636053;2372.6678265042906;2377.3343463830156;2295.21962532738;2319.7448280689027;2321.2455951815728;2322.4890524084676;2331.895064722092;2258.0516183203094;2261.095561775303;2267.1724820440586;2267.8639281643154;2269.7843704848015;8667.523286219255;8794.812700285443;8828.69099581518;8883.466991980436;8899.510526921016;5178.223266510054;5483.862903427406;5484.588655850827;5492.1212605982855;5500.917486237709;3394.7623666343366;3441.2257242120572;3485.686288234071;3492.388831954423;3507;1156.150229581257;1157.062779148892;1157.5254145800182;1174.0431548288118;1188.536470776398;12423.565175218824;12536.74926501474;12614.68463288416;12625;12626.873731262753;4310.633596144363;4425.048614547888;4579.862604121881;4587.839425620087;4599.5400459953735;9685.757856053515;9694.854577181348;9700.708978730649;9709.077637624414;9711.951440242754;5264.473552644705;5266.183741520071;5267.7366131694025;5271.841844744664;5274.551663108602;3970.821313040862;4156.480439945007;4263.616274535245;4401.317795741666;4924.187509060965;3517.191046059421;3828.5022947017264;3835.808209589565;3851.730378873508;3867.091233560111;1046.4773754187638;1085.940273284977;1094.529352378469;1101.8567586213742;1111.7998760223238;860.4149178558515;893.25413279912;894.9394966964169;931.3852857114272;955.1165172215811;5579.358373786985;5848.4793953571525;6024.096385542204;6027.065804800263;6061.393860613904;433.5837595907964;434.7826086956522;444.32462656761544;449.8762840218966;455.90198107406405;3867.400552914303;3962.40563915415;4023.1953609277675;4034.3948407738485;4326.848560300375;10977.451127443595;11024.44877756109;11050.33697978124;11053.944730276296;11084.833727494093;10975.012248897638;10978.12175026012;10979.780404392028;11031.282966607145;11132.944335278271;7884.172161922916;7950.562719050507;8002.9599852000365;8188.7952801180445;8212.63043163059;6055.636661800306;6077.574569780073;6157.107219453064;6225.346338634559;6330.746770129143;9980.401175929177;10300;10301.9484902575;10367.844482332923;10459.895401045893;9240.491772952284;10686.198535110054;10750.892491074988;10797.838032429363;10813.189010824062;7064.187618423947;7675.2324767522805;7706;7769.689212431439;8073.071596766447;8402.831943360976;8487.872681909652;8523.95738021306;8617.138286171332;8670.0896405879;7572.204918483701;7647.082350118021;7753.37972962173;7826.9433626459695;7879.527228366316;7589.6205189739185;7664.693412263447;7773.883391749241;7776.766696999099;7927.445078844657;6484.416402523795;6529.967350163409;6556.18047744032;6582.17722784652;6702.430293424918;4795.736234507136;4813.879653008703;4843.24929635907;4926.630502712239;5035.269885866455;4906.9018619626695;4995.47547507521;5030.798768049237;5093.439721630692;5142.64001519905 21:30:32 INFO - PROCESS | 10042 | |4;prototype.html;325.3103420748013;333.2368875275618;341.12161184948746;344.7896782962394;347.2482076304802;5228.790848366066;5320.414754377025;5320.733963301829;5331.773692050826;5357.517823395893;5260.947390526094;5288.947110528894;5293.602979776513;5313.654612450197;5333.4399888011785;3949.2101579684036;4081.9183616327655;4086.121483880965;4152.97923510382;4187.937180942288;4182.832686692529;4186.74879507229;4193.937090943638;4214.620684138427;4223.282042052859;4157.293260145767;4163.437935878648;4169.9791501042455;4171.749695018293;4184.435101261336;3941.783201923907;3963.64327210551;4121.48481439817;4164.729292596002;4195.091233488786;3677.4667673187237;3683.244934788362;3691.2063906260014;3695;3697.3159965406485;5129.9230511542355;5138.869448721275;5185.274061631375;5197.506236907488;5202.323697919284;4610.40064791575;4697.577218050357;4734.384530011111;4755.714657120584;4782.282657601353;5386.165144402624;5399.975009371486;5405.891882162374;5407.351117865842;5412.134058550613;3814.389697648363;4025.879223623296;4053.2096241232675;4059.0867054912705;4084.81618327176;5691.467297052814;5691.772329106872;5713.342965558931;5714.228579141846;5715.971420142872;4022.773054218433;4051.7568945862754;4060;4067.91864162721;4073.490813648294;4128.814203360856;4135.81388837497;4145.523264824524;4166.354215096665;4177.415161877339;4492.3710680504755;4673.415823022122;4693.272542755878;4697.976510117427;4699.459562150328;5548.195511650788;5555.444455554412;5555.611107222537;5566.165075238747;5610.895914032238;1433.2260579287276;1433.3263366217861;1434.5624584501618;1440.5246268731294;1445.7060930467173;896.090468174803;916.2029034739819;961.9470929098827;965.5413678502655;974.7270764186039;5188.766505507186;5289.259503669489;5327.547158491571;5346.278252435949;5376.112941364631;5633.690147041952;5635.1828984796975;5669.546436285087;5676.218652860069;5682.602217844794;5138.30632864566;5234.581233501387;5289.629725919149;5327.706976116273;5347.224652425377;2970.3514549425277;2972.316367235505;2985.283531952359;2988.775841811829;3008.2329006103305;5837.47462728348;5893.499052580493;5898.911516327258;5934.43622855828;5960.76156953717;5572.860678482989;5731.742071606787;5780;5801.361850196475;5802.245708057925;5872.2366092408565;5889.852753681193;5896;5906.409359064145;5911.645301281937;5426.4844839741745;5650.152477128464;5657.3776884543495;5738.856528586819;5754;5582.581306402118;5586.441355864381;5592.133219351007;5644.6613203207935;5654.434556544313;5887;5894;5929.52563794904;5947.405259474191;5968.910466342922;4089.629973958638;4156.8129434174925;4194.203101410722;4203.852865149827;4240.91518169641;5643.548516118619;5645.633033852787;5650.29371328584;5668.433156684298;5682.176084467812;5427.674339539641;5554.444555544414;5560.833175004756;5569.275994120739;5580.581456390706;5522.282103326542;5530.640508366943;5535.5848311376;5540.196671482532;5587.273654425061;5459.454054594509;5464.961657285103;5468.976478702905;5481.2874326338915;5537.307836520435;5341.626086174086;5400.7569659364635;5472.370677371994;5567.638103523258;5581.7209139543675;5403.64876283056;5451.781928722965;5453.2365468833605;5453.26380938584;5456.781728730806 21:30:32 INFO - PROCESS | 10042 | |5;yui.html;698.4412470023981;730.6383340246579;732.1360794262771;766.674163480521;792.1800936031207;14932.626684332883;15566.221688915566;15572.143532105729;15604;15610.609734756637;13892.23592702401;14203.857961420408;14392.424303027892;14393.280335983185;14473.131612103281;778.4122987144726;794.4002278279919;795.316028215734;795.9204079592023;796.2913007423398;679.2562144451817;684.0560027162509;789.7788619186637;808.7654580171743;809.6154326694802;852.6674596907211;852.7356519478982;853.189470003496;854.2098558833086;854.2567965869671;837.2673910328463;841.7727213652341;844.0926004545139;844.8605980013291;845.5518575155178;513.8792383789806;524.2843518597126;609.1289456077807;620.798240571816;621.9595726277778;14043.438262469592;14053.64865878351;14055.578332650037;14066.578002659937;14091.859081409157;13491.66270843227;14331.211783351911;14334.354954027094;14396.424143034266;14414.855851441456;12334.876651233462;12406.25562466255;12590.937045314806;12829.935850320782;13273.469061237636;4200.264953633102;4204.66362690984;4210.431591735107;4387.122575484916;4453.51011388747;87837;88652;88744;89336.99999999935;89515;10676.679699608869;10688.625898093529;10879.497715525473;11243.325400475998;11821.349825759493;21651.242206522697;21774;21788.237411690516;21797.67303490449;21844.23545175943;8308.252257296872;8332.62503187358;8539.14608539141;8625.39622226438;8697.913020869837;4652.720836749738;4669.2996050592;4786.425628924481;4842.733649649233;4855.89222897346;3254.33286176338;3333.116724068124;3347.447671134284;3347.8326083696206;3348.3805495982833;555.419586532075;563.9679386722288;565.3357305166413;573.3263415486787;577.7082573300456;569.7834822767322;586.9325027621793;607.9603877369659;617.4165413684116;629.0532748213909;8231.382646301552;8404.705835295736;8455.239028487465;8462.87305690415;8540.27407670355;514.2055524215097;529.4546616984512;574.8620331120501;599.4485073732177;606.3996643323078;4046.6964977626794;4120.990357362465;4230.809613567397;4240.957590424118;4336.132773445323;122180.38909805394;131102.34448827695;134330;143494.2825285867;143498.2825085889;102392.48803755933;104007.47996260121;113703.43148284206;114781;115143.2728509073;85986;87307.56346218102;87716;88473.55763221142;88742.55628721815;9376.859347109936;9423.434593924387;9749.9025009749;9989.60041598328;9995.900040999497;53612;54302.728486357315;54863.72568137134;55040;55768.6827936833;47053.29420058634;66274;75032;76109.23890761021;76154.23845761472;10952.34285942846;11067.114630829676;11181.776364472827;11348.716282092684;11488.253263537843;12433.254004759743;12590.622281331574;12685.8097128545;12776.488940442277;13139.34303284851;12490.87509124897;12992.545260915822;13018;13529.323533823073;13666.385012674255;13755.31223438844;14457.421703131757;14729.705405891607;14834.925825371236;15298.158601277037;13462.59612211596;13790.448382064606;14063.296835158406;14278.143311401349;14350.138991660533;10466.16270698327;11090.223684342018;11138.33170009802;11366.318020918772;11920.642380728244;9260.583273752833;9349.589440181908;9547.618095276111;11431.885681143081;12012.819807703067 21:30:32 INFO - PROCESS | 10042 | __end_tp_report 21:30:32 INFO - PROCESS | 10042 | __start_cc_report 21:30:32 INFO - PROCESS | 10042 | _x_x_mozilla_cycle_collect,1120 21:30:32 INFO - PROCESS | 10042 | __end_cc_report 21:30:32 INFO - PROCESS | 10042 | __startTimestamp1475209832304__endTimestamp 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | ------- Summary: start ------- 21:30:32 INFO - PROCESS | 10042 | Number of tests: 6 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#0] dojo.html Cycles:165 Average:5312.93 Median:5504.50 stddev:609.38 (11.1%) stddev-sans-first:583.02 21:30:32 INFO - PROCESS | 10042 | Values: 2975.8 3005.0 3005.5 3032.7 3051.9 5200.3 5272.1 5337.7 5413.3 5419.5 5273.7 5348.3 5405.8 5418.3 5532.9 4832.0 4854.2 4882.5 4914.5 4942.6 4935.6 4978.3 5007.3 5035.2 5084.5 4965.5 4980.6 5011.0 5025.0 5069.4 4745.0 4774.3 4844.8 4892.6 4918.3 4785.7 4793.0 4796.4 4801.6 4860.0 5299.2 5374.7 5386.4 5394.3 5394.8 5580.4 5613.2 5675.9 5749.4 5765.8 5722.1 5722.5 5786.8 5837.4 5859.3 5382.0 5386.6 5389.2 5390.5 5391.7 5749.2 5780.4 5918.6 5920.5 5929.1 5587.2 5619.2 5621.6 5634.6 5697.9 5704.5 5716.2 5718.0 5720.2 5720.4 5529.6 5633.6 5678.4 5679.6 5693.4 5571.1 5619.6 5645.4 5650.8 5703.8 4357.0 4359.6 4360.3 4366.9 4423.3 3878.4 3894.5 3898.9 3939.9 3948.3 5270.8 5314.1 5381.9 5424.8 5438.0 5751.1 5751.7 5754.0 5768.3 5820.0 5363.4 5437.8 5441.3 5442.3 5443.5 4772.1 4804.2 4807.4 4894.3 4993.3 5957.9 5986.0 5996.4 6057.1 6064.5 5728.7 5771.6 5788.7 5790.5 5796.1 5815.4 5842.0 5882.9 5998.5 6009.4 5556.7 5585.6 5611.5 5646.0 5655.0 5636.4 5637.8 5639.5 5645.9 5684.5 5414.5 5457.3 5485.4 5537.2 5537.5 5568.2 5589.7 5591.1 5614.3 5678.7 5557.9 5558.8 5562.4 5563.7 5572.2 5504.5 5583.1 5601.6 5655.8 5659.5 5382.9 5392.1 5394.5 5420.7 5496.8 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#1] ext.html Cycles:180 Average:65735.60 Median:216511.11 stddev:139990.49 (64.7%) stddev-sans-first:140297.71 21:30:32 INFO - PROCESS | 10042 | Values: 576.3 603.1 626.4 631.6 638.2 34666.0 35414.5 35455.8 35466.6 43053.8 42047.6 46254.0 46309.3 46311.8 46318.8 8900.6 9020.5 9051.2 9064.2 9065.4 8048.4 8221.1 8886.6 10613.5 10891.6 11022.2 11103.9 11110.7 11110.7 11114.1 10882.6 10979.9 10988.9 11012.2 11013.3 8005.2 8213.9 10307.6 10587.4 10608.5 41988.6 42355.6 42394.0 42397.6 42411.0 3475.6 3572.5 3731.9 3832.4 3913.2 31307.4 31727.8 32144.8 32177.8 32215.4 4265.0 4360.8 4380.3 4431.9 4456.4 388856.0 389225.1 392527.0 393575.0 395206.0 56723.4 56869.1 57197.7 57250.4 57273.4 60193.4 60302.4 60332.4 60341.7 60462.1 15363.0 15884.6 15901.3 15904.4 15911.4 10882.8 12155.8 12390.8 12394.5 12402.9 13931.7 15455.2 15955.8 16036.3 16498.0 5973.6 6093.5 6216.5 6228.3 6261.6 936.8 953.2 1038.1 1085.9 1094.5 29151.0 30734.8 31142.5 31437.2 31558.8 1044.7 1091.8 1137.2 1153.2 1184.1 15996.2 16373.5 16409.4 16502.4 16734.4 536716.0 537173.0 537408.0 540307.0 540883.0 50272.5 51145.2 55679.2 56840.0 57877.0 1304.9 1310.1 1316.4 1332.7 1333.9 30537.8 32632.0 32925.7 33158.2 33435.7 52287.2 52686.7 52966.0 53005.7 53052.5 472107.0 493445.0 494310.0 770382.0 775187.0 27745.7 27877.7 28054.9 28147.3 28454.3 47051.0 47601.5 47960.0 48042.5 48295.3 40103.2 40117.0 40366.6 42067.6 42225.6 39447.2 40439.6 40460.6 41882.0 41970.8 40211.4 40990.6 41462.4 41499.0 41500.0 33418.3 35824.5 36455.6 36746.6 36951.0 27615.3 27886.7 27904.9 27912.4 28025.7 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#2] jquery.html Cycles:180 Average:28579.45 Median:19653.07 stddev:78728.09 (400.6%) stddev-sans-first:78920.47 21:30:32 INFO - PROCESS | 10042 | Values: 377.7 390.2 396.6 401.7 417.7 13458.9 15496.7 16697.4 19284.5 19548.0 19272.2 19866.9 19918.8 19937.4 19945.0 5760.7 5765.1 5943.1 5980.6 5998.2 5857.3 5872.4 5897.9 5904.3 5945.8 5571.6 5797.7 5811.4 5852.1 5869.0 5771.4 5820.9 5848.3 5864.2 5886.6 5185.5 5266.8 5271.4 5421.1 5465.7 13932.7 14124.8 14167.2 14283.2 14380.2 2329.6 2414.0 2857.2 2881.1 2896.2 11905.4 13375.5 14180.5 14202.3 14566.3 1894.5 1894.5 1915.9 1937.0 1981.0 80103.0 82218.0 82412.6 82968.6 86455.0 10994.6 11165.4 11241.5 11262.5 11358.4 15830.0 15860.8 15864.3 15890.4 15896.8 7320.8 7923.1 7973.7 8005.0 8101.9 7405.4 7555.5 7657.4 7750.3 7766.7 4722.8 4769.1 4786.6 4800.3 4941.0 1893.7 2000.7 2030.3 2034.0 2081.4 926.2 930.0 939.2 950.6 964.8 18267.6 19299.1 19355.6 19365.1 19574.7 957.4 970.7 988.7 995.7 1057.3 9772.5 10587.6 10651.1 10680.4 10751.7 440128.0 481055.0 481327.0 482390.5 490784.0 94719.0 96279.5 100342.0 101107.5 101861.5 993.6 1021.5 1070.0 1070.5 1073.5 16657.3 16871.3 17081.6 17417.1 17917.9 38928.4 40767.0 42204.4 43572.3 44557.0 57926.1 57954.5 58157.0 58990.0 60540.7 5332.8 5937.4 7869.2 8468.0 8594.4 12295.5 12852.2 12999.4 13037.8 13166.2 6607.0 10723.6 10945.9 11341.5 12134.5 11063.5 11206.6 11439.1 11586.7 12233.9 9202.6 12028.9 12031.4 12409.8 12545.0 8362.2 8427.3 8438.3 8896.0 8923.6 11425.8 11520.1 11617.4 11637.2 12049.4 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#3] mootools.html Cycles:180 Average:5755.02 Median:4593.69 stddev:3350.38 (72.9%) stddev-sans-first:3343.28 21:30:32 INFO - PROCESS | 10042 | Values: 1330.7 1475.4 1499.5 1651.3 1765.7 7384.9 8594.9 8866.9 8869.4 9126.2 8784.3 8819.7 8834.5 8854.9 8862.0 2312.7 2346.7 2358.4 2365.6 2378.1 2290.0 2308.5 2383.7 2387.5 2388.3 2319.9 2322.5 2333.7 2372.7 2377.3 2295.2 2319.7 2321.2 2322.5 2331.9 2258.1 2261.1 2267.2 2267.9 2269.8 8667.5 8794.8 8828.7 8883.5 8899.5 5178.2 5483.9 5484.6 5492.1 5500.9 3394.8 3441.2 3485.7 3492.4 3507.0 1156.2 1157.1 1157.5 1174.0 1188.5 12423.6 12536.7 12614.7 12625.0 12626.9 4310.6 4425.0 4579.9 4587.8 4599.5 9685.8 9694.9 9700.7 9709.1 9712.0 5264.5 5266.2 5267.7 5271.8 5274.6 3970.8 4156.5 4263.6 4401.3 4924.2 3517.2 3828.5 3835.8 3851.7 3867.1 1046.5 1085.9 1094.5 1101.9 1111.8 860.4 893.3 894.9 931.4 955.1 5579.4 5848.5 6024.1 6027.1 6061.4 433.6 434.8 444.3 449.9 455.9 3867.4 3962.4 4023.2 4034.4 4326.8 10977.5 11024.4 11050.3 11053.9 11084.8 10975.0 10978.1 10979.8 11031.3 11132.9 7884.2 7950.6 8003.0 8188.8 8212.6 6055.6 6077.6 6157.1 6225.3 6330.7 9980.4 10300.0 10301.9 10367.8 10459.9 9240.5 10686.2 10750.9 10797.8 10813.2 7064.2 7675.2 7706.0 7769.7 8073.1 8402.8 8487.9 8524.0 8617.1 8670.1 7572.2 7647.1 7753.4 7826.9 7879.5 7589.6 7664.7 7773.9 7776.8 7927.4 6484.4 6530.0 6556.2 6582.2 6702.4 4795.7 4813.9 4843.2 4926.6 5035.3 4906.9 4995.5 5030.8 5093.4 5142.6 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#4] prototype.html Cycles:180 Average:4673.24 Median:5337.53 stddev:1364.73 (25.6%) stddev-sans-first:1328.97 21:30:32 INFO - PROCESS | 10042 | Values: 325.3 333.2 341.1 344.8 347.2 5228.8 5320.4 5320.7 5331.8 5357.5 5260.9 5288.9 5293.6 5313.7 5333.4 3949.2 4081.9 4086.1 4153.0 4187.9 4182.8 4186.7 4193.9 4214.6 4223.3 4157.3 4163.4 4170.0 4171.7 4184.4 3941.8 3963.6 4121.5 4164.7 4195.1 3677.5 3683.2 3691.2 3695.0 3697.3 5129.9 5138.9 5185.3 5197.5 5202.3 4610.4 4697.6 4734.4 4755.7 4782.3 5386.2 5400.0 5405.9 5407.4 5412.1 3814.4 4025.9 4053.2 4059.1 4084.8 5691.5 5691.8 5713.3 5714.2 5716.0 4022.8 4051.8 4060.0 4067.9 4073.5 4128.8 4135.8 4145.5 4166.4 4177.4 4492.4 4673.4 4693.3 4698.0 4699.5 5548.2 5555.4 5555.6 5566.2 5610.9 1433.2 1433.3 1434.6 1440.5 1445.7 896.1 916.2 961.9 965.5 974.7 5188.8 5289.3 5327.5 5346.3 5376.1 5633.7 5635.2 5669.5 5676.2 5682.6 5138.3 5234.6 5289.6 5327.7 5347.2 2970.4 2972.3 2985.3 2988.8 3008.2 5837.5 5893.5 5898.9 5934.4 5960.8 5572.9 5731.7 5780.0 5801.4 5802.2 5872.2 5889.9 5896.0 5906.4 5911.6 5426.5 5650.2 5657.4 5738.9 5754.0 5582.6 5586.4 5592.1 5644.7 5654.4 5887.0 5894.0 5929.5 5947.4 5968.9 4089.6 4156.8 4194.2 4203.9 4240.9 5643.5 5645.6 5650.3 5668.4 5682.2 5427.7 5554.4 5560.8 5569.3 5580.6 5522.3 5530.6 5535.6 5540.2 5587.3 5459.5 5465.0 5469.0 5481.3 5537.3 5341.6 5400.8 5472.4 5567.6 5581.7 5403.6 5451.8 5453.2 5453.3 5456.8 21:30:32 INFO - PROCESS | 10042 | 21:30:32 INFO - PROCESS | 10042 | [#5] yui.html Cycles:180 Average:21789.65 Median:4420.32 stddev:33281.98 (752.9%) stddev-sans-first:33337.67 21:30:32 INFO - PROCESS | 10042 | Values: 698.4 730.6 732.1 766.7 792.2 14932.6 15566.2 15572.1 15604.0 15610.6 13892.2 14203.9 14392.4 14393.3 14473.1 778.4 794.4 795.3 795.9 796.3 679.3 684.1 789.8 808.8 809.6 852.7 852.7 853.2 854.2 854.3 837.3 841.8 844.1 844.9 845.6 513.9 524.3 609.1 620.8 622.0 14043.4 14053.6 14055.6 14066.6 14091.9 13491.7 14331.2 14334.4 14396.4 14414.9 12334.9 12406.3 12590.9 12829.9 13273.5 4200.3 4204.7 4210.4 4387.1 4453.5 87837.0 88652.0 88744.0 89337.0 89515.0 10676.7 10688.6 10879.5 11243.3 11821.3 21651.2 21774.0 21788.2 21797.7 21844.2 8308.3 8332.6 8539.1 8625.4 8697.9 4652.7 4669.3 4786.4 4842.7 4855.9 3254.3 3333.1 3347.4 3347.8 3348.4 555.4 564.0 565.3 573.3 577.7 569.8 586.9 608.0 617.4 629.1 8231.4 8404.7 8455.2 8462.9 8540.3 514.2 529.5 574.9 599.4 606.4 4046.7 4121.0 4230.8 4241.0 4336.1 122180.4 131102.3 134330.0 143494.3 143498.3 102392.5 104007.5 113703.4 114781.0 115143.3 85986.0 87307.6 87716.0 88473.6 88742.6 9376.9 9423.4 9749.9 9989.6 9995.9 53612.0 54302.7 54863.7 55040.0 55768.7 47053.3 66274.0 75032.0 76109.2 76154.2 10952.3 11067.1 11181.8 11348.7 11488.3 12433.3 12590.6 12685.8 12776.5 13139.3 12490.9 12992.5 13018.0 13529.3 13666.4 13755.3 14457.4 14729.7 14834.9 15298.2 13462.6 13790.4 14063.3 14278.1 14350.1 10466.2 11090.2 11138.3 11366.3 11920.6 9260.6 9349.6 9547.6 11431.9 12012.8 21:30:32 INFO - PROCESS | 10042 | -------- Summary: end -------- 21:30:32 INFO - PROCESS | 10042 | 21:30:33 INFO - TEST-INFO | 10042: exit 0 21:30:33 INFO - TEST-OK | dromaeo_css | took 1115893ms 21:30:33 INFO - TEST-START | kraken 21:30:33 INFO - operating with platform_type : linux_ 21:30:33 INFO - Initialising browser for kraken test... 21:30:33 INFO - TEST-INFO | started process 10348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7iAgCb/profile http://localhost:46681/getInfo.html) 21:30:37 INFO - PROCESS | 10348 | __metrics Screen width/height:1600/1200 21:30:37 INFO - PROCESS | 10348 | colorDepth:24 21:30:37 INFO - PROCESS | 10348 | Browser inner width/height: 1024/697 21:30:37 INFO - PROCESS | 10348 | __metrics 21:30:38 INFO - PROCESS | 10348 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:30:38 INFO - PROCESS | 10348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:30:38 INFO - PROCESS | 10348 | console.error: PushService: 21:30:38 INFO - PROCESS | 10348 | stateChangeProcessEnqueue: Error transitioning state 21:30:38 INFO - PROCESS | 10348 | UnknownError 21:30:39 INFO - TEST-INFO | 10348: exit 0 21:30:39 INFO - Browser initialized. 21:30:39 INFO - Running cycle 1/1 for kraken test... 21:30:39 INFO - TEST-INFO | started process 10432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7iAgCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:51 INFO - PROCESS | 10432 | RSS: Main: 173023232 21:30:51 INFO - PROCESS | 10432 | 21:30:53 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:54 INFO - PROCESS | 10432 | RSS: Main: 232599552 21:30:54 INFO - PROCESS | 10432 | 21:30:57 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-dft) 21:30:57 INFO - PROCESS | 10432 | RSS: Main: 216993792 21:30:57 INFO - PROCESS | 10432 | 21:31:01 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-fft) 21:31:01 INFO - PROCESS | 10432 | RSS: Main: 298143744 21:31:01 INFO - PROCESS | 10432 | 21:31:03 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-oscillator) 21:31:04 INFO - PROCESS | 10432 | RSS: Main: 208158720 21:31:04 INFO - PROCESS | 10432 | 21:31:06 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:31:07 INFO - PROCESS | 10432 | RSS: Main: 212860928 21:31:07 INFO - PROCESS | 10432 | 21:31:10 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-darkroom) 21:31:10 INFO - PROCESS | 10432 | RSS: Main: 249503744 21:31:10 INFO - PROCESS | 10432 | 21:31:14 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-desaturate) 21:31:14 INFO - PROCESS | 10432 | RSS: Main: 248365056 21:31:14 INFO - PROCESS | 10432 | 21:31:17 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46681/tests/kraken/driver.html?testName=json-parse-financial) 21:31:18 INFO - PROCESS | 10432 | RSS: Main: 248221696 21:31:18 INFO - PROCESS | 10432 | 21:31:19 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:31:20 INFO - PROCESS | 10432 | RSS: Main: 210542592 21:31:20 INFO - PROCESS | 10432 | 21:31:21 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:31:22 INFO - PROCESS | 10432 | RSS: Main: 217833472 21:31:22 INFO - PROCESS | 10432 | 21:31:24 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:31:25 INFO - PROCESS | 10432 | RSS: Main: 222674944 21:31:25 INFO - PROCESS | 10432 | 21:31:27 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:31:28 INFO - PROCESS | 10432 | RSS: Main: 223997952 21:31:28 INFO - PROCESS | 10432 | 21:31:31 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:31:31 INFO - PROCESS | 10432 | RSS: Main: 221179904 21:31:31 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46681/tests/kraken/driver.html?testName=ai-astar) 21:31:33 INFO - PROCESS | 10432 | RSS: Main: 273113088 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | __start_tp_report 21:31:33 INFO - PROCESS | 10432 | _x_x_mozilla_page_load 21:31:33 INFO - PROCESS | 10432 | _x_x_mozilla_page_load_details 21:31:33 INFO - PROCESS | 10432 | |i|pagename|runs| 21:31:33 INFO - PROCESS | 10432 | |0;ai-astar;108;110;112;111;111;110;113;110;111;112 21:31:33 INFO - PROCESS | 10432 | |1;audio-beat-detection;143;122;122;163;117;118;116;119;152;119 21:31:33 INFO - PROCESS | 10432 | |2;audio-dft;161;162;162;163;161;169;161;161;161;161 21:31:33 INFO - PROCESS | 10432 | |3;audio-fft;75;75;75;109;76;76;75;76;120;75 21:31:33 INFO - PROCESS | 10432 | |4;audio-oscillator;84;81;111;83;82;82;101;82;81;115 21:31:33 INFO - PROCESS | 10432 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;117;117 21:31:33 INFO - PROCESS | 10432 | |6;imaging-darkroom;147;148;146;147;146;148;147;148;147;147 21:31:33 INFO - PROCESS | 10432 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;97;96 21:31:33 INFO - PROCESS | 10432 | |8;json-parse-financial;52;59;49;49;51;51;51;51;51;51 21:31:33 INFO - PROCESS | 10432 | |9;json-stringify-tinderbox;61;60;60;60;60;63;60;60;63;61 21:31:33 INFO - PROCESS | 10432 | |10;stanford-crypto-aes;79;80;78;79;78;86;79;78;77;86 21:31:33 INFO - PROCESS | 10432 | |11;stanford-crypto-ccm;127;123;122;123;134;125;134;125;166;125 21:31:33 INFO - PROCESS | 10432 | |12;stanford-crypto-pbkdf2;163;163;162;160;161;163;163;163;162;162 21:31:33 INFO - PROCESS | 10432 | |13;stanford-crypto-sha256-iterative;64;65;64;65;67;63;66;65;64;67 21:31:33 INFO - PROCESS | 10432 | __end_tp_report 21:31:33 INFO - PROCESS | 10432 | __start_cc_report 21:31:33 INFO - PROCESS | 10432 | _x_x_mozilla_cycle_collect,1613 21:31:33 INFO - PROCESS | 10432 | __end_cc_report 21:31:33 INFO - PROCESS | 10432 | __startTimestamp1475209893651__endTimestamp 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | ------- Summary: start ------- 21:31:33 INFO - PROCESS | 10432 | Number of tests: 14 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.40 (1.3%) stddev-sans-first:1.05 21:31:33 INFO - PROCESS | 10432 | Values: 108.0 110.0 112.0 111.0 111.0 110.0 113.0 110.0 111.0 112.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:122.00 stddev:17.04 (14.0%) stddev-sans-first:17.31 21:31:33 INFO - PROCESS | 10432 | Values: 143.0 122.0 122.0 163.0 117.0 118.0 116.0 119.0 152.0 119.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:2.49 (1.5%) stddev-sans-first:2.60 21:31:33 INFO - PROCESS | 10432 | Values: 161.0 162.0 162.0 163.0 161.0 169.0 161.0 161.0 161.0 161.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:16.71 (22.3%) stddev-sans-first:17.45 21:31:33 INFO - PROCESS | 10432 | Values: 75.0 75.0 75.0 109.0 76.0 76.0 75.0 76.0 120.0 75.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:13.44 (16.4%) stddev-sans-first:14.07 21:31:33 INFO - PROCESS | 10432 | Values: 84.0 81.0 111.0 83.0 82.0 82.0 101.0 82.0 81.0 115.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:31:33 INFO - PROCESS | 10432 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 21:31:33 INFO - PROCESS | 10432 | Values: 147.0 148.0 146.0 147.0 146.0 148.0 147.0 148.0 147.0 147.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 21:31:33 INFO - PROCESS | 10432 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 97.0 96.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:2.80 (5.5%) stddev-sans-first:2.96 21:31:33 INFO - PROCESS | 10432 | Values: 52.0 59.0 49.0 49.0 51.0 51.0 51.0 51.0 51.0 51.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.50 stddev:1.23 (2.0%) stddev-sans-first:1.30 21:31:33 INFO - PROCESS | 10432 | Values: 61.0 60.0 60.0 60.0 60.0 63.0 60.0 60.0 63.0 61.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.27 (4.1%) stddev-sans-first:3.44 21:31:33 INFO - PROCESS | 10432 | Values: 79.0 80.0 78.0 79.0 78.0 86.0 79.0 78.0 77.0 86.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:126.00 stddev:13.22 (10.5%) stddev-sans-first:13.96 21:31:33 INFO - PROCESS | 10432 | Values: 127.0 123.0 122.0 123.0 134.0 125.0 134.0 125.0 166.0 125.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 21:31:33 INFO - PROCESS | 10432 | Values: 163.0 163.0 162.0 160.0 161.0 163.0 163.0 163.0 162.0 162.0 21:31:33 INFO - PROCESS | 10432 | 21:31:33 INFO - PROCESS | 10432 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 21:31:33 INFO - PROCESS | 10432 | Values: 64.0 65.0 64.0 65.0 67.0 63.0 66.0 65.0 64.0 67.0 21:31:33 INFO - PROCESS | 10432 | -------- Summary: end -------- 21:31:33 INFO - PROCESS | 10432 | 21:31:34 INFO - TEST-INFO | 10432: exit 0 21:31:34 INFO - TEST-OK | kraken | took 61530ms 21:31:34 INFO - SUITE-END | took 1177s 21:31:35 INFO - Completed test suite (00:19:37) 21:31:35 INFO - javascript benchmark 21:31:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.8363290019047, 3004.984975075125, 3005.5040918248505, 3032.6664066952644, 3051.8779248830047, 5200.323957885479, 5272.103742363798, 5337.733113344332, 5413.26920865683, 5419.512243898049, 5273.709945952981, 5348.277982472365, 5405.810796622119, 5418.2685337479425, 5532.944670553294, 4832.0335932813405, 4854.223324268118, 4882.511748825107, 4914.459409464956, 4942.579880710144, 4935.555799978001, 4978.2532620107095, 5007.273945277932, 5035.219540971137, 5084.491550844923, 4965.453800081988, 4980.576650984671, 5010.974945125269, 5025.0, 5069.417017043051, 4744.976275118637, 4774.307725379836, 4844.806207751686, 4892.559669629751, 4918.336024636664, 4785.736784476852, 4792.952070479286, 4796.44840843304, 4801.615870730333, 4859.95140048602, 5299.231611416361, 5374.731263436852, 5386.3536375634785, 5394.298741163663, 5394.757235924393, 5580.358258800209, 5613.158026296048, 5675.9432405675825, 5749.367569567345, 5765.827025189251, 5722.055860783007, 5722.484976352148, 5786.797462088806, 5837.387074357216, 5859.267591551056, 5381.973090134525, 5386.649867758583, 5389.191621256843, 5390.460953904618, 5391.73041347931, 5749.223854779635, 5780.421957804186, 5918.644881307136, 5920.4967577755515, 5929.140274660236, 5587.217789509472, 5619.213310136584, 5621.578381621313, 5634.6337488063145, 5697.914531282034, 5704.543636509069, 5716.228309178291, 5717.971410142923, 5720.1991721159075, 5720.399358067426, 5529.612927095065, 5633.57748168889, 5678.403767604342, 5679.574031947621, 5693.430656934356, 5571.1086226203615, 5619.578531610146, 5645.435456454404, 5650.7739690412745, 5703.800366987219, 4356.956430435655, 4359.607635312837, 4360.280553708666, 4366.912661746811, 4423.270160423558, 3878.4376265441915, 3894.4937158169255, 3898.90252743678, 3939.881803545898, 3948.3485224937563, 5270.78916843322, 5314.096603577401, 5381.865453363697, 5424.810131645373, 5437.972810135924, 5751.051076572318, 5751.654900705971, 5753.971230143822, 5768.2501274834, 5820.0, 5363.410024897258, 5437.755301011464, 5441.319835020622, 5442.292501974718, 5443.537299329601, 4772.141014617402, 4804.183288840905, 4807.399075115611, 4894.3147959285725, 4993.251012348177, 5957.880842383128, 5985.970070149621, 5996.430339117776, 6057.091436284504, 6064.4541991221, 5728.742206600797, 5771.624844385102, 5788.652680839163, 5790.478856902899, 5796.101604251347, 5815.4184581543195, 5842.0, 5882.94117058841, 5998.4601385875485, 6009.399060093956, 5556.666600004012, 5585.581081418991, 5611.523020543136, 5646.040173170653, 5655.0, 5636.3799982002765, 5637.830865074055, 5639.548836093185, 5645.887082258249, 5684.516816070515, 5414.512693857571, 5457.317835270591, 5485.369182544058, 5537.169424586345, 5537.529310008695, 5568.248286481273, 5589.748461319332, 5591.133374326986, 5614.2701448811395, 5678.6876721779045, 5557.916631250615, 5558.833235002957, 5562.443755624567, 5563.721813909369, 5572.219889215432, 5504.504594586507, 5583.0787919992745, 5601.607887448003, 5655.830325090254, 5659.462351076641, 5382.919256211082, 5392.05639013179, 5394.487523685244, 5420.728963551728, 5496.7526461308535], "value": 5270.7850608153585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3285772075532, 603.0772917436323, 626.4205609810926, 631.6241836107516, 638.1608185236411, 34665.99999999997, 35414.46878296827, 35455.82272088639, 35466.64533354662, 43053.784731076375, 42047.579524204746, 46254.0, 46309.30536041962, 46311.76844115775, 46318.76840615792, 8900.554972251377, 9020.548972551345, 9051.185393314601, 9064.18422341989, 9065.410748301372, 8048.356131509495, 8221.054578723433, 8886.644534218623, 10613.522391492363, 10891.618793342235, 11022.173336999756, 11103.944480277587, 11110.666679999573, 11110.666679999613, 11114.11087113029, 10882.61910833121, 10979.945100274528, 10988.945055274753, 11012.229143959967, 11013.339199648046, 8005.159458256858, 8213.917860821435, 10307.587696492206, 10587.417692026935, 10608.469576521144, 41988.580114198776, 42355.57644423547, 42394.0, 42397.57602423998, 42411.0, 3475.6176820549717, 3572.517710109128, 3731.8693845715543, 3832.3676593362343, 3913.236918800835, 31307.37385252305, 31727.84136079305, 32144.839275803704, 32177.839110804296, 32215.355692886013, 4264.978675106605, 4360.847370342023, 4380.3371093148935, 4431.889202769924, 4456.398386217851, 388856.0, 389225.05387473165, 392527.0, 393575.0, 395206.0, 56723.43276567264, 56869.14696279559, 57197.71401143051, 57250.41243813461, 57273.42726572681, 60193.39806601878, 60302.396976029675, 60332.39667603355, 60341.69829150914, 60462.09306860401, 15363.0, 15884.602884927737, 15901.284442200129, 15904.363825447084, 15911.443099491693, 10882.836757448644, 12155.817662735066, 12390.81413778794, 12394.504219831286, 12402.937985310016, 13931.721365572632, 15455.227238638023, 15955.760663590056, 16036.278367473491, 16498.0, 5973.611715238582, 6093.542984276197, 6216.502679785606, 6228.252609686867, 6261.624302541771, 936.8173206224857, 953.2374100719396, 1038.050184081572, 1085.8696956365286, 1094.5452010317929, 29151.0, 30734.846325768227, 31142.532862007087, 31437.214069648442, 31558.808767771407, 1044.6657069737762, 1091.82530795074, 1137.2323681514945, 1153.221575436577, 1184.0645889747004, 15996.200189990454, 16373.508794736177, 16409.42567010149, 16502.42241521541, 16734.414295499842, 536716.0, 537173.0, 537408.0, 540307.0, 540883.0, 50272.49727502751, 51145.23282150771, 55679.164812527844, 56840.0, 57877.0, 1304.8956083513297, 1310.1418570836117, 1316.4273541009884, 1332.6934804994712, 1333.8599447057918, 30537.847310763304, 32632.0, 32925.67074329226, 33158.17104572309, 33435.66564334326, 52287.21569176389, 52686.736566316926, 52966.0, 53005.7349713249, 53052.46947530475, 472107.0, 493445.0, 494310.0, 770382.0, 775187.0, 27745.722542774314, 27877.721222788325, 28054.85972570124, 28147.279036700667, 28454.288642783267, 47051.0, 47601.52398475971, 47960.0, 48042.5195748038, 48295.27557086717, 40103.19793604053, 40117.0, 40366.59633403629, 42067.57932420759, 42225.577744222166, 39447.21105577815, 40439.595604043585, 40460.59539404568, 41882.0, 41970.790146049076, 40211.396829047, 40990.5653302133, 41462.378064328455, 41499.0, 41500.0, 33418.33163336671, 35824.46263306105, 36455.635443645224, 36746.63253367432, 36951.0, 27615.30961725973, 27886.721132789226, 27904.860475697493, 27912.44175116527, 28025.71974280231], "value": 20294.020715963055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.724261289259, 390.1884081111287, 396.6271704597678, 401.7208040411915, 417.73056378635783, 13458.865411345883, 15496.690066198684, 16697.415590454337, 19284.517887052796, 19548.0, 19272.229110835586, 19866.900665496687, 19918.800811991874, 19937.40187794365, 19945.0, 5760.683162426076, 5765.077587585987, 5943.108533719955, 5980.581359304851, 5998.160257563923, 5857.326407463153, 5872.354041055481, 5897.941020589804, 5904.321003084658, 5945.821625351246, 5571.6378435401775, 5797.739101740411, 5811.418858114197, 5852.12218167274, 5868.972929737279, 5771.394003629601, 5820.883582328351, 5848.2689663792025, 5864.179014937912, 5886.558508111866, 5185.481451854822, 5266.789328426858, 5271.393789714193, 5421.105517589593, 5465.672059676433, 13932.721345573033, 14124.788128178085, 14167.220802855838, 14283.21442320672, 14380.209088500129, 2329.592321343758, 2414.022320960014, 2857.22854829197, 2881.063654312336, 2896.174590241792, 11905.404729763564, 13375.464981400732, 14180.50368237117, 14202.289885505787, 14566.344514496874, 1894.4506093232947, 1894.5168981909662, 1915.9329423470112, 1937.0, 1980.9702854457194, 80103.0, 82218.0, 82412.58793706053, 82968.58515707383, 86454.99999999937, 10994.560217591206, 11165.38590377537, 11241.494132764044, 11262.493187806569, 11358.432078396212, 15830.0, 15860.841391585936, 15864.286107125206, 15890.443834465737, 15896.841031589767, 7320.780376588605, 7923.12845586985, 7973.681052757941, 8004.959975200203, 8101.918980810235, 7405.407567394595, 7555.471117021865, 7657.367292787783, 7750.302472777477, 7766.689332426639, 4722.811087556459, 4769.093872164347, 4786.569208771228, 4800.303955926371, 4940.975295123501, 1893.7064754963003, 2000.7499062617173, 2030.319842852661, 2034.010005292218, 2081.4172031831113, 926.2219735422277, 929.972100836976, 939.1641439119189, 950.5674917912334, 964.7973925475728, 18267.63464730698, 19299.131539080776, 19355.612887742165, 19365.12856921442, 19574.70637940432, 957.3920560444029, 970.7233438470143, 988.658912675126, 995.7361299255703, 1057.2652006855162, 9772.462514561767, 10587.57649694019, 10651.147908167328, 10680.359178449318, 10751.731206719738, 440128.0, 481055.0, 481327.0, 482390.46852423454, 490784.0, 94719.0, 96279.51860240794, 100342.0, 101107.49446252722, 101861.49069254607, 993.6373223773271, 1021.4994652620163, 1069.9518521666544, 1070.4808168038496, 1073.4847273308699, 16657.250423731202, 16871.325146994473, 17081.572960676083, 17417.12914354252, 17917.910410447865, 38928.41607375948, 40767.0, 42204.366934495396, 43572.34641480317, 44557.0, 57926.13110803426, 57954.494323039246, 58157.0, 58990.0, 60540.69729651324, 5332.813351532678, 5937.406259374028, 7869.190086280073, 8468.0, 8594.441361311494, 12295.508179672714, 12852.164609300366, 12999.415026324028, 13037.804432933324, 13166.210027398387, 6607.0, 10723.624673136403, 10945.945270273916, 11341.546338146713, 12134.514619415124, 11063.502142403771, 11206.607768728056, 11439.14206434504, 11586.71033224176, 12233.938830305791, 9202.619607058994, 12028.939855301018, 12031.398430078636, 12409.75180496367, 12545.0, 8362.163783621832, 8427.325813934993, 8438.282745966662, 8895.955520222617, 8923.598438070172, 11425.828612570653, 11520.13598980063, 11617.419129043345, 11637.185397022127, 12049.397530123284], "value": 9117.304256733521, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.7405056014081, 1475.3950880139141, 1499.490173341064, 1651.2816924637784, 1765.691004074286, 7384.889226661598, 8594.87107693385, 8866.86699699505, 8869.37914345996, 9126.178643922045, 8784.341174411913, 8819.735407937773, 8834.514101724402, 8854.86717699235, 8862.0, 2312.7224733032017, 2346.683197768305, 2358.445765245166, 2365.597848365773, 2378.0844374915696, 2289.9885500572473, 2308.503671710582, 2383.6901202843605, 2387.486690361572, 2388.3312672451652, 2319.8724070176136, 2322.547103314846, 2333.7316208636053, 2372.6678265042906, 2377.3343463830156, 2295.21962532738, 2319.7448280689027, 2321.2455951815728, 2322.4890524084676, 2331.895064722092, 2258.0516183203094, 2261.095561775303, 2267.1724820440586, 2267.8639281643154, 2269.7843704848015, 8667.523286219255, 8794.812700285443, 8828.69099581518, 8883.466991980436, 8899.510526921016, 5178.223266510054, 5483.862903427406, 5484.588655850827, 5492.1212605982855, 5500.917486237709, 3394.7623666343366, 3441.2257242120572, 3485.686288234071, 3492.388831954423, 3507.0, 1156.150229581257, 1157.062779148892, 1157.5254145800182, 1174.0431548288118, 1188.536470776398, 12423.565175218824, 12536.74926501474, 12614.68463288416, 12625.0, 12626.873731262753, 4310.633596144363, 4425.048614547888, 4579.862604121881, 4587.839425620087, 4599.5400459953735, 9685.757856053515, 9694.854577181348, 9700.708978730649, 9709.077637624414, 9711.951440242754, 5264.473552644705, 5266.183741520071, 5267.7366131694025, 5271.841844744664, 5274.551663108602, 3970.821313040862, 4156.480439945007, 4263.616274535245, 4401.317795741666, 4924.187509060965, 3517.191046059421, 3828.5022947017264, 3835.808209589565, 3851.730378873508, 3867.091233560111, 1046.4773754187638, 1085.940273284977, 1094.529352378469, 1101.8567586213742, 1111.7998760223238, 860.4149178558515, 893.25413279912, 894.9394966964169, 931.3852857114272, 955.1165172215811, 5579.358373786985, 5848.4793953571525, 6024.096385542204, 6027.065804800263, 6061.393860613904, 433.5837595907964, 434.7826086956522, 444.32462656761544, 449.8762840218966, 455.90198107406405, 3867.400552914303, 3962.40563915415, 4023.1953609277675, 4034.3948407738485, 4326.848560300375, 10977.451127443595, 11024.44877756109, 11050.33697978124, 11053.944730276296, 11084.833727494093, 10975.012248897638, 10978.12175026012, 10979.780404392028, 11031.282966607145, 11132.944335278271, 7884.172161922916, 7950.562719050507, 8002.9599852000365, 8188.7952801180445, 8212.63043163059, 6055.636661800306, 6077.574569780073, 6157.107219453064, 6225.346338634559, 6330.746770129143, 9980.401175929177, 10300.0, 10301.9484902575, 10367.844482332923, 10459.895401045893, 9240.491772952284, 10686.198535110054, 10750.892491074988, 10797.838032429363, 10813.189010824062, 7064.187618423947, 7675.2324767522805, 7706.0, 7769.689212431439, 8073.071596766447, 8402.831943360976, 8487.872681909652, 8523.95738021306, 8617.138286171332, 8670.0896405879, 7572.204918483701, 7647.082350118021, 7753.37972962173, 7826.9433626459695, 7879.527228366316, 7589.6205189739185, 7664.693412263447, 7773.883391749241, 7776.766696999099, 7927.445078844657, 6484.416402523795, 6529.967350163409, 6556.18047744032, 6582.17722784652, 6702.430293424918, 4795.736234507136, 4813.879653008703, 4843.24929635907, 4926.630502712239, 5035.269885866455, 4906.9018619626695, 4995.47547507521, 5030.798768049237, 5093.439721630692, 5142.64001519905], "value": 4495.127480065208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3103420748013, 333.2368875275618, 341.12161184948746, 344.7896782962394, 347.2482076304802, 5228.790848366066, 5320.414754377025, 5320.733963301829, 5331.773692050826, 5357.517823395893, 5260.947390526094, 5288.947110528894, 5293.602979776513, 5313.654612450197, 5333.4399888011785, 3949.2101579684036, 4081.9183616327655, 4086.121483880965, 4152.97923510382, 4187.937180942288, 4182.832686692529, 4186.74879507229, 4193.937090943638, 4214.620684138427, 4223.282042052859, 4157.293260145767, 4163.437935878648, 4169.9791501042455, 4171.749695018293, 4184.435101261336, 3941.783201923907, 3963.64327210551, 4121.48481439817, 4164.729292596002, 4195.091233488786, 3677.4667673187237, 3683.244934788362, 3691.2063906260014, 3695.0, 3697.3159965406485, 5129.9230511542355, 5138.869448721275, 5185.274061631375, 5197.506236907488, 5202.323697919284, 4610.40064791575, 4697.577218050357, 4734.384530011111, 4755.714657120584, 4782.282657601353, 5386.165144402624, 5399.975009371486, 5405.891882162374, 5407.351117865842, 5412.134058550613, 3814.389697648363, 4025.879223623296, 4053.2096241232675, 4059.0867054912705, 4084.81618327176, 5691.467297052814, 5691.772329106872, 5713.342965558931, 5714.228579141846, 5715.971420142872, 4022.773054218433, 4051.7568945862754, 4060.0, 4067.91864162721, 4073.490813648294, 4128.814203360856, 4135.81388837497, 4145.523264824524, 4166.354215096665, 4177.415161877339, 4492.3710680504755, 4673.415823022122, 4693.272542755878, 4697.976510117427, 4699.459562150328, 5548.195511650788, 5555.444455554412, 5555.611107222537, 5566.165075238747, 5610.895914032238, 1433.2260579287276, 1433.3263366217861, 1434.5624584501618, 1440.5246268731294, 1445.7060930467173, 896.090468174803, 916.2029034739819, 961.9470929098827, 965.5413678502655, 974.7270764186039, 5188.766505507186, 5289.259503669489, 5327.547158491571, 5346.278252435949, 5376.112941364631, 5633.690147041952, 5635.1828984796975, 5669.546436285087, 5676.218652860069, 5682.602217844794, 5138.30632864566, 5234.581233501387, 5289.629725919149, 5327.706976116273, 5347.224652425377, 2970.3514549425277, 2972.316367235505, 2985.283531952359, 2988.775841811829, 3008.2329006103305, 5837.47462728348, 5893.499052580493, 5898.911516327258, 5934.43622855828, 5960.76156953717, 5572.860678482989, 5731.742071606787, 5780.0, 5801.361850196475, 5802.245708057925, 5872.2366092408565, 5889.852753681193, 5896.0, 5906.409359064145, 5911.645301281937, 5426.4844839741745, 5650.152477128464, 5657.3776884543495, 5738.856528586819, 5754.0, 5582.581306402118, 5586.441355864381, 5592.133219351007, 5644.6613203207935, 5654.434556544313, 5887.0, 5894.0, 5929.52563794904, 5947.405259474191, 5968.910466342922, 4089.629973958638, 4156.8129434174925, 4194.203101410722, 4203.852865149827, 4240.91518169641, 5643.548516118619, 5645.633033852787, 5650.29371328584, 5668.433156684298, 5682.176084467812, 5427.674339539641, 5554.444555544414, 5560.833175004756, 5569.275994120739, 5580.581456390706, 5522.282103326542, 5530.640508366943, 5535.5848311376, 5540.196671482532, 5587.273654425061, 5459.454054594509, 5464.961657285103, 5468.976478702905, 5481.2874326338915, 5537.307836520435, 5341.626086174086, 5400.7569659364635, 5472.370677371994, 5567.638103523258, 5581.7209139543675, 5403.64876283056, 5451.781928722965, 5453.2365468833605, 5453.26380938584, 5456.781728730806], "value": 4239.855363663576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4412470023981, 730.6383340246579, 732.1360794262771, 766.674163480521, 792.1800936031207, 14932.626684332883, 15566.221688915566, 15572.143532105729, 15604.0, 15610.609734756637, 13892.23592702401, 14203.857961420408, 14392.424303027892, 14393.280335983185, 14473.131612103281, 778.4122987144726, 794.4002278279919, 795.316028215734, 795.9204079592023, 796.2913007423398, 679.2562144451817, 684.0560027162509, 789.7788619186637, 808.7654580171743, 809.6154326694802, 852.6674596907211, 852.7356519478982, 853.189470003496, 854.2098558833086, 854.2567965869671, 837.2673910328463, 841.7727213652341, 844.0926004545139, 844.8605980013291, 845.5518575155178, 513.8792383789806, 524.2843518597126, 609.1289456077807, 620.798240571816, 621.9595726277778, 14043.438262469592, 14053.64865878351, 14055.578332650037, 14066.578002659937, 14091.859081409157, 13491.66270843227, 14331.211783351911, 14334.354954027094, 14396.424143034266, 14414.855851441456, 12334.876651233462, 12406.25562466255, 12590.937045314806, 12829.935850320782, 13273.469061237636, 4200.264953633102, 4204.66362690984, 4210.431591735107, 4387.122575484916, 4453.51011388747, 87837.0, 88652.0, 88744.0, 89336.99999999935, 89515.0, 10676.679699608869, 10688.625898093529, 10879.497715525473, 11243.325400475998, 11821.349825759493, 21651.242206522697, 21774.0, 21788.237411690516, 21797.67303490449, 21844.23545175943, 8308.252257296872, 8332.62503187358, 8539.14608539141, 8625.39622226438, 8697.913020869837, 4652.720836749738, 4669.2996050592, 4786.425628924481, 4842.733649649233, 4855.89222897346, 3254.33286176338, 3333.116724068124, 3347.447671134284, 3347.8326083696206, 3348.3805495982833, 555.419586532075, 563.9679386722288, 565.3357305166413, 573.3263415486787, 577.7082573300456, 569.7834822767322, 586.9325027621793, 607.9603877369659, 617.4165413684116, 629.0532748213909, 8231.382646301552, 8404.705835295736, 8455.239028487465, 8462.87305690415, 8540.27407670355, 514.2055524215097, 529.4546616984512, 574.8620331120501, 599.4485073732177, 606.3996643323078, 4046.6964977626794, 4120.990357362465, 4230.809613567397, 4240.957590424118, 4336.132773445323, 122180.38909805394, 131102.34448827695, 134330.0, 143494.2825285867, 143498.2825085889, 102392.48803755933, 104007.47996260121, 113703.43148284206, 114781.0, 115143.2728509073, 85986.0, 87307.56346218102, 87716.0, 88473.55763221142, 88742.55628721815, 9376.859347109936, 9423.434593924387, 9749.9025009749, 9989.60041598328, 9995.900040999497, 53612.0, 54302.728486357315, 54863.72568137134, 55040.0, 55768.6827936833, 47053.29420058634, 66274.0, 75032.0, 76109.23890761021, 76154.23845761472, 10952.34285942846, 11067.114630829676, 11181.776364472827, 11348.716282092684, 11488.253263537843, 12433.254004759743, 12590.622281331574, 12685.8097128545, 12776.488940442277, 13139.34303284851, 12490.87509124897, 12992.545260915822, 13018.0, 13529.323533823073, 13666.385012674255, 13755.31223438844, 14457.421703131757, 14729.705405891607, 14834.925825371236, 15298.158601277037, 13462.59612211596, 13790.448382064606, 14063.296835158406, 14278.143311401349, 14350.138991660533, 10466.16270698327, 11090.223684342018, 11138.33170009802, 11366.318020918772, 11920.642380728244, 9260.583273752833, 9349.589440181908, 9547.618095276111, 11431.885681143081, 12012.819807703067], "value": 7385.949763863496, "unit": "score"}], "name": "dromaeo_css", "value": 7182.505292434914, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 112.0, 111.0, 111.0, 110.0, 113.0, 110.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 122.0, 163.0, 117.0, 118.0, 116.0, 119.0, 152.0, 119.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 161.0, 169.0, 161.0, 161.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 76.0, 76.0, 75.0, 76.0, 120.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 111.0, 83.0, 82.0, 82.0, 101.0, 82.0, 81.0, 115.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 97.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 59.0, 49.0, 49.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 63.0, 60.0, 60.0, 63.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 78.0, 86.0, 79.0, 78.0, 77.0, 86.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 122.0, 123.0, 134.0, 125.0, 134.0, 125.0, 166.0, 125.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 160.0, 161.0, 163.0, 163.0, 163.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 67.0, 63.0, 66.0, 65.0, 64.0, 67.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1485.0000000000002, "alertThreshold": 2.0}]} 21:31:35 INFO - Return code: 0 21:31:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:31:35 INFO - # TBPL SUCCESS # 21:31:35 INFO - Running post-action listener: _resource_record_post_action 21:31:35 INFO - [mozharness: 2016-09-30 04:31:35.439041Z] Finished run-tests step (success) 21:31:35 INFO - Running post-run listener: _resource_record_post_run 21:31:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 409493504; Read time: 0; Write time: 255908 21:31:35 INFO - TinderboxPrint: CPU usage
13.0% 21:31:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:31:35 INFO - TinderboxPrint: I/O write bytes / time
409,493,504 / 255,908 21:31:35 INFO - TinderboxPrint: CPU idle
8,298.6 (87.0%) 21:31:35 INFO - TinderboxPrint: CPU user
1,194.9 (12.5%) 21:31:35 INFO - TinderboxPrint: Swap in / out
0 / 0 21:31:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103952384; Read time: 0; Write time: 46372 21:31:35 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288591872; Read time: 0; Write time: 202996 21:31:36 INFO - Running post-run listener: _upload_blobber_files 21:31:36 INFO - Blob upload gear active. 21:31:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:31:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:31:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:40 INFO - (blobuploader) - INFO - Done attempting. 21:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:40 INFO - (blobuploader) - INFO - Done attempting. 21:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:41 INFO - (blobuploader) - INFO - Done attempting. 21:31:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:31:41 INFO - Return code: 0 21:31:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:31:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:31:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3ace767293747cba07c5bf326fc3eed3e6f2177d33b3d18aed01422e8d9616ceee0b1e47a057a87ffc22b0d3cff4c3e0fb1e28dd255efb0cf9cf10ab3b03255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2875c890c3aee0e1261d6183d3298fcdc18a5944cb61927dc0f1194a41e93971ce4a191207bbe3596caec2a46fae5ba88666d651e3d6142b3b21b2782542edca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17526ab6235875b4ed1457512ab299d39a0ac226b9a823d6fce6db0f7a53925b0ab85a1fb70036db9b25a0d63c63ed2e0d364fe9a6d8a758bc4e3c09d9f30ba0"} 21:31:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:31:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:31:41 INFO - Contents: 21:31:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3ace767293747cba07c5bf326fc3eed3e6f2177d33b3d18aed01422e8d9616ceee0b1e47a057a87ffc22b0d3cff4c3e0fb1e28dd255efb0cf9cf10ab3b03255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2875c890c3aee0e1261d6183d3298fcdc18a5944cb61927dc0f1194a41e93971ce4a191207bbe3596caec2a46fae5ba88666d651e3d6142b3b21b2782542edca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17526ab6235875b4ed1457512ab299d39a0ac226b9a823d6fce6db0f7a53925b0ab85a1fb70036db9b25a0d63c63ed2e0d364fe9a6d8a758bc4e3c09d9f30ba0"} 21:31:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:31:41 INFO - Copying logs to upload dir... 21:31:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:31:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.668046 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-29 21:31:41.418415) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 21:31:41.421764) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3ace767293747cba07c5bf326fc3eed3e6f2177d33b3d18aed01422e8d9616ceee0b1e47a057a87ffc22b0d3cff4c3e0fb1e28dd255efb0cf9cf10ab3b03255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2875c890c3aee0e1261d6183d3298fcdc18a5944cb61927dc0f1194a41e93971ce4a191207bbe3596caec2a46fae5ba88666d651e3d6142b3b21b2782542edca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17526ab6235875b4ed1457512ab299d39a0ac226b9a823d6fce6db0f7a53925b0ab85a1fb70036db9b25a0d63c63ed2e0d364fe9a6d8a758bc4e3c09d9f30ba0"} build_url:https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/bJZoRyK9Q5e9O34xRqIx8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3ace767293747cba07c5bf326fc3eed3e6f2177d33b3d18aed01422e8d9616ceee0b1e47a057a87ffc22b0d3cff4c3e0fb1e28dd255efb0cf9cf10ab3b03255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2875c890c3aee0e1261d6183d3298fcdc18a5944cb61927dc0f1194a41e93971ce4a191207bbe3596caec2a46fae5ba88666d651e3d6142b3b21b2782542edca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17526ab6235875b4ed1457512ab299d39a0ac226b9a823d6fce6db0f7a53925b0ab85a1fb70036db9b25a0d63c63ed2e0d364fe9a6d8a758bc4e3c09d9f30ba0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 21:31:41.448240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:31:41.448622) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1475207335.822204-1309570834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 21:31:41.533746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 21:31:41.534319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 21:31:41.534858) ========= ========= Total master_lag: 0.18 =========