builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1477665340.6 results: success (0) buildid: 20161028061458 builduid: cb8c03018e444ac3bbc1816141639458 revision: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.602396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.603162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.603474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.620046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.620356) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 07:35:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.5M=0s 2016-10-28 07:35:41 (87.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.739196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.739537) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:40.791784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 07:35:40.792159) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1561c917ee27c3ea04bd69467e5b8c7c08102f2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1561c917ee27c3ea04bd69467e5b8c7c08102f2a --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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 07:35:41,254 truncating revision to first 12 chars 2016-10-28 07:35:41,254 Setting DEBUG logging. 2016-10-28 07:35:41,254 attempt 1/10 2016-10-28 07:35:41,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1561c917ee27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 07:35:42,623 unpacking tar archive at: mozilla-central-1561c917ee27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.705779 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 07:35:42.511974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:42.512500) ========= script_repo_revision: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:42.513175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:42.513639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 07:35:42.523182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-28 07:35:42.523597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:35:43 INFO - MultiFileLogger online at 20161028 07:35:43 in /builds/slave/test 07:35:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:35:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:43 INFO - {'append_to_log': False, 07:35:43 INFO - 'base_work_dir': '/builds/slave/test', 07:35:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:35:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:43 INFO - 'branch': 'Firefox-Non-PGO', 07:35:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:43 INFO - 'config_files': ('talos/linux_config.py',), 07:35:43 INFO - 'default_actions': ('clobber', 07:35:43 INFO - 'read-buildbot-config', 07:35:43 INFO - 'download-and-extract', 07:35:43 INFO - 'populate-webroot', 07:35:43 INFO - 'create-virtualenv', 07:35:43 INFO - 'install', 07:35:43 INFO - 'run-tests'), 07:35:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:43 INFO - 'download_minidump_stackwalk': True, 07:35:43 INFO - 'download_symbols': 'ondemand', 07:35:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:43 INFO - 'installer_path': 'installer.exe', 07:35:43 INFO - 'log_level': 'info', 07:35:43 INFO - 'log_name': 'talos', 07:35:43 INFO - 'log_to_console': True, 07:35:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:35:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:35:43 INFO - 'opt_config_files': (), 07:35:43 INFO - 'pip_index': False, 07:35:43 INFO - 'sps_profile': False, 07:35:43 INFO - 'sps_profile_interval': 0, 07:35:43 INFO - 'suite': 'dromaeojs', 07:35:43 INFO - 'system_bits': '32', 07:35:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:43 INFO - 'title': 'talos-linux64-ix-001', 07:35:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:43 INFO - 'use_talos_json': True, 07:35:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:43 INFO - 'work_dir': 'build'} 07:35:43 INFO - [mozharness: 2016-10-28 14:35:43.084568Z] Running clobber step. 07:35:43 INFO - Running pre-action listener: _resource_record_pre_action 07:35:43 INFO - Running main action method: clobber 07:35:43 INFO - rmtree: /builds/slave/test/build 07:35:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:43 INFO - Running post-action listener: _resource_record_post_action 07:35:43 INFO - [mozharness: 2016-10-28 14:35:43.554563Z] Finished clobber step (success) 07:35:43 INFO - [mozharness: 2016-10-28 14:35:43.554664Z] Running read-buildbot-config step. 07:35:43 INFO - Running pre-action listener: _resource_record_pre_action 07:35:43 INFO - Running main action method: read_buildbot_config 07:35:43 INFO - Using buildbot properties: 07:35:43 INFO - { 07:35:43 INFO - "project": "", 07:35:43 INFO - "product": "firefox", 07:35:43 INFO - "script_repo_revision": "production", 07:35:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:35:43 INFO - "repository": "", 07:35:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:35:43 INFO - "buildid": "20161028061458", 07:35:43 INFO - "pgo_build": "False", 07:35:43 INFO - "basedir": "/builds/slave/test", 07:35:43 INFO - "buildnumber": 791, 07:35:43 INFO - "slavename": "talos-linux64-ix-001", 07:35:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:35:43 INFO - "platform": "ubuntu64_hw", 07:35:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:35:43 INFO - "branch": "mozilla-central", 07:35:43 INFO - "repo_path": "mozilla-central", 07:35:43 INFO - "revision": "1561c917ee27c3ea04bd69467e5b8c7c08102f2a", 07:35:43 INFO - "stage_platform": "linux64", 07:35:43 INFO - "builduid": "cb8c03018e444ac3bbc1816141639458", 07:35:43 INFO - "slavebuilddir": "test" 07:35:43 INFO - } 07:35:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:35:43 INFO - Running post-action listener: _resource_record_post_action 07:35:43 INFO - [mozharness: 2016-10-28 14:35:43.557098Z] Finished read-buildbot-config step (success) 07:35:43 INFO - [mozharness: 2016-10-28 14:35:43.557187Z] Running download-and-extract step. 07:35:43 INFO - Running pre-action listener: _resource_record_pre_action 07:35:43 INFO - Running main action method: download_and_extract 07:35:43 INFO - mkdir: /builds/slave/test/build/tests 07:35:43 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')]} 07:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/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 07:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/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 07:35:44 INFO - Downloaded 1361 bytes. 07:35:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:35:44 INFO - Using the following test package requirements: 07:35:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:35:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'jsshell-linux-x86_64.zip'], 07:35:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:35:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:35:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:35:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:35:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:35:44 INFO - Http code: 200 07:35:44 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 07:35:44 INFO - x-amz-cf-id: E2Tz6hRDQNQ4J8c-9mfB9zm3dekSX-a42iuu2Uq8XIqWT77I51e7EQ== 07:35:44 INFO - x-amz-version-id: IPoR7hctjhSv6RLJaVpEbCAbJti42OAQ 07:35:44 INFO - Expected file size: 20424522 07:35:44 INFO - Obtained file size: 20424522 07:35:48 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 07:35:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:35:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:35:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:35:49 INFO - Http code: 200 07:35:49 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 07:35:49 INFO - x-amz-cf-id: 3-8YHkeNvCtPDAi93aMeGcHvuo2GL-ijYUvvt1TduY_JQBUIiE1k4w== 07:35:49 INFO - x-amz-version-id: IPoR7hctjhSv6RLJaVpEbCAbJti42OAQ 07:35:49 INFO - Expected file size: 20424522 07:35:49 INFO - Obtained file size: 20424522 07:35:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:35:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:35:54 INFO - Http code: 200 07:35:54 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 07:35:54 INFO - x-amz-cf-id: VL0X_cIFeo-ik090T21lW7Wi3Iq4U7V1Mxo3GEOffpiXyRkvpDtyYA== 07:35:54 INFO - x-amz-version-id: W596Rbkvy3gVpXOTABlH_xEHhLyRkx.i 07:35:54 INFO - Expected file size: 14409028 07:35:54 INFO - Obtained file size: 14409028 07:35:55 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')]} 07:35:55 INFO - trying https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/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 07:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/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 07:35:56 INFO - Downloaded 55488294 bytes. 07:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:35:56 INFO - mkdir: /builds/slave/test/properties 07:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:56 INFO - Contents: 07:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - Running post-action listener: set_extra_try_arguments 07:35:56 INFO - [mozharness: 2016-10-28 14:35:56.909404Z] Finished download-and-extract step (success) 07:35:56 INFO - [mozharness: 2016-10-28 14:35:56.909630Z] Running populate-webroot step. 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: populate_webroot 07:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:56 INFO - '--tppagecycles', 07:35:56 INFO - '7'], 07:35:56 INFO - 'tests': ['tsvgm']}}, 07:35:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['damp', 'tps']}, 07:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['damp', 'tps']}, 07:35:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['dromaeo_dom']}, 07:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['basic_compositor_video']}, 07:35:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore', 07:35:56 INFO - 'tabpaint']}, 07:35:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['tsvgx', 07:35:56 INFO - 'tsvgr_opacity', 07:35:56 INFO - 'tart', 07:35:56 INFO - 'tscrollx', 07:35:56 INFO - 'cart']}, 07:35:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:56 INFO - 'tsvgr_opacity', 07:35:56 INFO - 'tart', 07:35:56 INFO - 'tscrollx', 07:35:56 INFO - 'cart']}, 07:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--disable-e10s'], 07:35:56 INFO - 'tests': ['tp5o']}, 07:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['tp5o']}, 07:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--disable-e10s', 07:35:56 INFO - '--xperf_path', 07:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:56 INFO - 'tests': ['tp5n']}, 07:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--xperf_path', 07:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:56 INFO - 'tests': ['tp5n']}}, 07:35:56 INFO - 'talos.zip': {'path': '', 07:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - [mozharness: 2016-10-28 14:35:56.930066Z] Finished populate-webroot step (success) 07:35:56 INFO - [mozharness: 2016-10-28 14:35:56.930155Z] Running create-virtualenv step. 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: create_virtualenv 07:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:56 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 07:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:57 INFO - Using real prefix '/usr' 07:35:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:59 INFO - Installing pip.................done. 07:35:59 INFO - Return code: 0 07:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:59 INFO - Reading from file tmpfile_stdout 07:35:59 INFO - Output received: 07:35:59 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) 07:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:59 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')]} 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 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')]} 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:35:59 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 07:35:59 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 07:35:59 INFO - Using env: {'DISPLAY': ':0', 07:35:59 INFO - 'HOME': '/home/cltbld', 07:35:59 INFO - 'LANG': 'en_US.UTF-8', 07:35:59 INFO - 'LANGUAGE': 'en_US:en', 07:35:59 INFO - 'LOGNAME': 'cltbld', 07:35:59 INFO - 'MAIL': '/var/mail/cltbld', 07:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:59 INFO - 'MOZ_NO_REMOTE': '1', 07:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:59 INFO - 'NO_EM_RESTART': '1', 07:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:59 INFO - 'PWD': '/builds/slave/test', 07:35:59 INFO - 'SHELL': '/bin/bash', 07:35:59 INFO - 'SHLVL': '1', 07:35:59 INFO - 'TERM': 'linux', 07:35:59 INFO - 'TMOUT': '86400', 07:35:59 INFO - 'USER': 'cltbld', 07:35:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:59 INFO - '_': '/tools/buildbot/bin/python'} 07:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:59 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 07:35:59 INFO - Cleaning up... 07:35:59 INFO - Return code: 0 07:35:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:59 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')]} 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 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')]} 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:35:59 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 07:35:59 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 07:35:59 INFO - Using env: {'DISPLAY': ':0', 07:35:59 INFO - 'HOME': '/home/cltbld', 07:35:59 INFO - 'LANG': 'en_US.UTF-8', 07:35:59 INFO - 'LANGUAGE': 'en_US:en', 07:35:59 INFO - 'LOGNAME': 'cltbld', 07:35:59 INFO - 'MAIL': '/var/mail/cltbld', 07:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:59 INFO - 'MOZ_NO_REMOTE': '1', 07:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:59 INFO - 'NO_EM_RESTART': '1', 07:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:59 INFO - 'PWD': '/builds/slave/test', 07:35:59 INFO - 'SHELL': '/bin/bash', 07:35:59 INFO - 'SHLVL': '1', 07:35:59 INFO - 'TERM': 'linux', 07:35:59 INFO - 'TMOUT': '86400', 07:35:59 INFO - 'USER': 'cltbld', 07:35:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:59 INFO - '_': '/tools/buildbot/bin/python'} 07:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:00 INFO - Downloading/unpacking psutil>=3.1.1 07:36:00 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 07:36:00 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 07:36:00 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 07:36:00 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 07:36:00 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 07:36:00 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 07:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:02 INFO - Installing collected packages: psutil 07:36:02 INFO - Running setup.py install for psutil 07:36:02 INFO - building 'psutil._psutil_linux' extension 07:36:02 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 07:36:02 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 07:36:02 INFO - building 'psutil._psutil_posix' extension 07:36:02 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 07:36:02 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 07:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:02 INFO - Successfully installed psutil 07:36:02 INFO - Cleaning up... 07:36:02 INFO - Return code: 0 07:36:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:02 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')]} 07:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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')]} 07:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:02 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 07:36:02 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 07:36:02 INFO - Using env: {'DISPLAY': ':0', 07:36:02 INFO - 'HOME': '/home/cltbld', 07:36:02 INFO - 'LANG': 'en_US.UTF-8', 07:36:02 INFO - 'LANGUAGE': 'en_US:en', 07:36:02 INFO - 'LOGNAME': 'cltbld', 07:36:02 INFO - 'MAIL': '/var/mail/cltbld', 07:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:02 INFO - 'MOZ_NO_REMOTE': '1', 07:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:02 INFO - 'NO_EM_RESTART': '1', 07:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:02 INFO - 'PWD': '/builds/slave/test', 07:36:02 INFO - 'SHELL': '/bin/bash', 07:36:02 INFO - 'SHLVL': '1', 07:36:02 INFO - 'TERM': 'linux', 07:36:02 INFO - 'TMOUT': '86400', 07:36:02 INFO - 'USER': 'cltbld', 07:36:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:02 INFO - '_': '/tools/buildbot/bin/python'} 07:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:03 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 07:36:03 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 07:36:03 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 07:36:03 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 07:36:03 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 07:36:03 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 07:36:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:04 INFO - Installing collected packages: mozsystemmonitor 07:36:04 INFO - Running setup.py install for mozsystemmonitor 07:36:05 INFO - Successfully installed mozsystemmonitor 07:36:05 INFO - Cleaning up... 07:36:05 INFO - Return code: 0 07:36:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:05 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')]} 07:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:05 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')]} 07:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:05 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:05 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 07:36:05 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 07:36:05 INFO - Using env: {'DISPLAY': ':0', 07:36:05 INFO - 'HOME': '/home/cltbld', 07:36:05 INFO - 'LANG': 'en_US.UTF-8', 07:36:05 INFO - 'LANGUAGE': 'en_US:en', 07:36:05 INFO - 'LOGNAME': 'cltbld', 07:36:05 INFO - 'MAIL': '/var/mail/cltbld', 07:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:05 INFO - 'MOZ_NO_REMOTE': '1', 07:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:05 INFO - 'NO_EM_RESTART': '1', 07:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:05 INFO - 'PWD': '/builds/slave/test', 07:36:05 INFO - 'SHELL': '/bin/bash', 07:36:05 INFO - 'SHLVL': '1', 07:36:05 INFO - 'TERM': 'linux', 07:36:05 INFO - 'TMOUT': '86400', 07:36:05 INFO - 'USER': 'cltbld', 07:36:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:05 INFO - '_': '/tools/buildbot/bin/python'} 07:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:05 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:07 INFO - warning: no files found matching '*.txt' 07:36:07 INFO - no previously-included directories found matching 'build' 07:36:07 INFO - no previously-included directories found matching 'dist' 07:36:07 INFO - no previously-included directories found matching '.git*' 07:36:07 INFO - Installing collected packages: jsonschema, functools32 07:36:07 INFO - Running setup.py install for functools32 07:36:07 INFO - warning: no files found matching '*.txt' 07:36:07 INFO - no previously-included directories found matching 'build' 07:36:07 INFO - no previously-included directories found matching 'dist' 07:36:07 INFO - no previously-included directories found matching '.git*' 07:36:07 INFO - Successfully installed jsonschema functools32 07:36:07 INFO - Cleaning up... 07:36:07 INFO - Return code: 0 07:36:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:07 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')]} 07:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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')]} 07:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:07 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 07:36:07 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 07:36:07 INFO - Using env: {'DISPLAY': ':0', 07:36:07 INFO - 'HOME': '/home/cltbld', 07:36:07 INFO - 'LANG': 'en_US.UTF-8', 07:36:07 INFO - 'LANGUAGE': 'en_US:en', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MAIL': '/var/mail/cltbld', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SHLVL': '1', 07:36:07 INFO - 'TERM': 'linux', 07:36:07 INFO - 'TMOUT': '86400', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - '_': '/tools/buildbot/bin/python'} 07:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:07 INFO - Cleaning up... 07:36:07 INFO - Return code: 0 07:36:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:07 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')]} 07:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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')]} 07:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:07 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 07:36:07 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 07:36:07 INFO - Using env: {'DISPLAY': ':0', 07:36:07 INFO - 'HOME': '/home/cltbld', 07:36:07 INFO - 'LANG': 'en_US.UTF-8', 07:36:07 INFO - 'LANGUAGE': 'en_US:en', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MAIL': '/var/mail/cltbld', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SHLVL': '1', 07:36:07 INFO - 'TERM': 'linux', 07:36:07 INFO - 'TMOUT': '86400', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - '_': '/tools/buildbot/bin/python'} 07:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:08 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 07:36:08 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 07:36:08 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 07:36:08 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 07:36:08 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 07:36:08 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 07:36:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 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 07:36:10 INFO - Downloading docopt-0.6.1.tar.gz 07:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:10 INFO - Running setup.py install for blobuploader 07:36:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:10 INFO - Running setup.py install for requests 07:36:11 INFO - Running setup.py install for docopt 07:36:11 INFO - Successfully installed blobuploader requests docopt 07:36:11 INFO - Cleaning up... 07:36:11 INFO - Return code: 0 07:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:11 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')]} 07:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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')]} 07:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:11 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 07:36:11 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 07:36:11 INFO - Using env: {'DISPLAY': ':0', 07:36:11 INFO - 'HOME': '/home/cltbld', 07:36:11 INFO - 'LANG': 'en_US.UTF-8', 07:36:11 INFO - 'LANGUAGE': 'en_US:en', 07:36:11 INFO - 'LOGNAME': 'cltbld', 07:36:11 INFO - 'MAIL': '/var/mail/cltbld', 07:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:11 INFO - 'MOZ_NO_REMOTE': '1', 07:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:11 INFO - 'NO_EM_RESTART': '1', 07:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:11 INFO - 'PWD': '/builds/slave/test', 07:36:11 INFO - 'SHELL': '/bin/bash', 07:36:11 INFO - 'SHLVL': '1', 07:36:11 INFO - 'TERM': 'linux', 07:36:11 INFO - 'TMOUT': '86400', 07:36:11 INFO - 'USER': 'cltbld', 07:36:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:11 INFO - '_': '/tools/buildbot/bin/python'} 07:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:11 INFO - Running setup.py (path:/tmp/pip-SGGnhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:11 INFO - Running setup.py (path:/tmp/pip-EJL4cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:11 INFO - Running setup.py (path:/tmp/pip-IVpTUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:11 INFO - Running setup.py (path:/tmp/pip-sZMpjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:12 INFO - Running setup.py (path:/tmp/pip-XVoK78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:12 INFO - Running setup.py (path:/tmp/pip-0ydQSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:12 INFO - Running setup.py (path:/tmp/pip-3Ea1em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:12 INFO - Running setup.py (path:/tmp/pip-_d4HHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:12 INFO - Running setup.py (path:/tmp/pip-ToUmFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:12 INFO - Running setup.py (path:/tmp/pip-EeWhCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:12 INFO - Running setup.py (path:/tmp/pip-EKyTqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:12 INFO - Running setup.py (path:/tmp/pip-RoNiKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:12 INFO - Running setup.py (path:/tmp/pip-QZZqYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:12 INFO - Running setup.py (path:/tmp/pip-_GETM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:12 INFO - Running setup.py (path:/tmp/pip-fQiMWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:12 INFO - Running setup.py (path:/tmp/pip-J4eXqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:12 INFO - Running setup.py (path:/tmp/pip-P2V83d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:12 INFO - Running setup.py install for manifestparser 07:36:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozcrash 07:36:13 INFO - Running setup.py install for mozdebug 07:36:13 INFO - Running setup.py install for mozdevice 07:36:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozfile 07:36:13 INFO - Running setup.py install for mozhttpd 07:36:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozinfo 07:36:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozInstall 07:36:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozleak 07:36:13 INFO - Running setup.py install for mozlog 07:36:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for moznetwork 07:36:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Running setup.py install for mozprocess 07:36:14 INFO - Running setup.py install for mozprofile 07:36:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Running setup.py install for mozrunner 07:36:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Running setup.py install for mozscreenshot 07:36:14 INFO - Running setup.py install for moztest 07:36:14 INFO - Running setup.py install for mozversion 07:36:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:14 INFO - Cleaning up... 07:36:14 INFO - Return code: 0 07:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:14 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:14 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 07:36:14 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 07:36:14 INFO - Using env: {'DISPLAY': ':0', 07:36:14 INFO - 'HOME': '/home/cltbld', 07:36:14 INFO - 'LANG': 'en_US.UTF-8', 07:36:14 INFO - 'LANGUAGE': 'en_US:en', 07:36:14 INFO - 'LOGNAME': 'cltbld', 07:36:14 INFO - 'MAIL': '/var/mail/cltbld', 07:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:14 INFO - 'MOZ_NO_REMOTE': '1', 07:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:14 INFO - 'NO_EM_RESTART': '1', 07:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:14 INFO - 'PWD': '/builds/slave/test', 07:36:14 INFO - 'SHELL': '/bin/bash', 07:36:14 INFO - 'SHLVL': '1', 07:36:14 INFO - 'TERM': 'linux', 07:36:14 INFO - 'TMOUT': '86400', 07:36:14 INFO - 'USER': 'cltbld', 07:36:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:14 INFO - '_': '/tools/buildbot/bin/python'} 07:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:14 INFO - Running setup.py (path:/tmp/pip-zng_9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:15 INFO - Running setup.py (path:/tmp/pip-fWbk3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:15 INFO - Running setup.py (path:/tmp/pip-hhMqgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:15 INFO - Running setup.py (path:/tmp/pip-OuhKoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:15 INFO - Running setup.py (path:/tmp/pip-qRYjn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:15 INFO - Running setup.py (path:/tmp/pip-a_ikfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:15 INFO - Running setup.py (path:/tmp/pip-jyY38I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:15 INFO - Running setup.py (path:/tmp/pip-KV4P3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:15 INFO - Running setup.py (path:/tmp/pip-pBkeJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:15 INFO - Running setup.py (path:/tmp/pip-kfXvnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:15 INFO - Running setup.py (path:/tmp/pip-Bsmycf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:15 INFO - Running setup.py (path:/tmp/pip-FZUz5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:15 INFO - Running setup.py (path:/tmp/pip-6REosz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:15 INFO - Running setup.py (path:/tmp/pip-_eg70R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:15 INFO - Running setup.py (path:/tmp/pip-bw21es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:16 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)) 07:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:16 INFO - Running setup.py (path:/tmp/pip-ONVcwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:16 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)) 07:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:16 INFO - Running setup.py (path:/tmp/pip-LA6KVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:16 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)) 07:36:16 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)) 07:36:16 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)) 07:36:16 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)) 07:36:16 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)) 07:36:16 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)) 07:36:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:16 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 07:36:16 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 07:36:16 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 07:36:16 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 07:36:16 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 07:36:16 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 07:36:18 INFO - Downloading blessings-1.6.tar.gz 07:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:18 INFO - Installing collected packages: blessings 07:36:18 INFO - Running setup.py install for blessings 07:36:18 INFO - Successfully installed blessings 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Current package versions: 07:36:18 INFO - argparse == 1.2.1 07:36:18 INFO - blessings == 1.6 07:36:18 INFO - blobuploader == 1.2.4 07:36:18 INFO - docopt == 0.6.1 07:36:18 INFO - functools32 == 3.2.3-2 07:36:18 INFO - jsonschema == 2.5.1 07:36:18 INFO - manifestparser == 1.1 07:36:18 INFO - mozInstall == 1.12 07:36:18 INFO - mozcrash == 0.17 07:36:18 INFO - mozdebug == 0.1 07:36:18 INFO - mozdevice == 0.48 07:36:18 INFO - mozfile == 1.2 07:36:18 INFO - mozhttpd == 0.7 07:36:18 INFO - mozinfo == 0.9 07:36:18 INFO - mozleak == 0.1 07:36:18 INFO - mozlog == 3.4 07:36:18 INFO - moznetwork == 0.27 07:36:18 INFO - mozprocess == 0.23 07:36:18 INFO - mozprofile == 0.28 07:36:18 INFO - mozrunner == 6.12 07:36:18 INFO - mozscreenshot == 0.1 07:36:18 INFO - mozsystemmonitor == 0.3 07:36:18 INFO - moztest == 0.7 07:36:18 INFO - mozversion == 1.4 07:36:18 INFO - psutil == 3.1.1 07:36:18 INFO - requests == 1.2.3 07:36:18 INFO - wsgiref == 0.1.2 07:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:18 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')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'DISPLAY': ':0', 07:36:18 INFO - 'HOME': '/home/cltbld', 07:36:18 INFO - 'LANG': 'en_US.UTF-8', 07:36:18 INFO - 'LANGUAGE': 'en_US:en', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MAIL': '/var/mail/cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SHLVL': '1', 07:36:18 INFO - 'TERM': 'linux', 07:36:18 INFO - 'TMOUT': '86400', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - '_': '/tools/buildbot/bin/python'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:18 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')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x7f0074327f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', '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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'DISPLAY': ':0', 07:36:18 INFO - 'HOME': '/home/cltbld', 07:36:18 INFO - 'LANG': 'en_US.UTF-8', 07:36:18 INFO - 'LANGUAGE': 'en_US:en', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MAIL': '/var/mail/cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SHLVL': '1', 07:36:18 INFO - 'TERM': 'linux', 07:36:18 INFO - 'TMOUT': '86400', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - '_': '/tools/buildbot/bin/python'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:19 INFO - Cleaning up... 07:36:19 INFO - Return code: 0 07:36:19 INFO - Running post-action listener: _resource_record_post_action 07:36:19 INFO - Running post-action listener: _start_resource_monitoring 07:36:19 INFO - Starting resource monitoring. 07:36:19 INFO - [mozharness: 2016-10-28 14:36:19.076537Z] Finished create-virtualenv step (success) 07:36:19 INFO - [mozharness: 2016-10-28 14:36:19.077096Z] Running install step. 07:36:19 INFO - Running pre-action listener: _resource_record_pre_action 07:36:19 INFO - Running main action method: install 07:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:19 INFO - Reading from file tmpfile_stdout 07:36:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:19 INFO - Reading from file tmpfile_stdout 07:36:19 INFO - Output received: 07:36:19 INFO - Usage: mozinstall [options] installer 07:36:19 INFO - Options: 07:36:19 INFO - -h, --help show this help message and exit 07:36:19 INFO - -d DEST, --destination=DEST 07:36:19 INFO - Directory to install application into. [default: 07:36:19 INFO - "/builds/slave/test"] 07:36:19 INFO - --app=APP Application being installed. [default: firefox] 07:36:19 INFO - mkdir: /builds/slave/test/build/application 07:36:19 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'] 07:36:19 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 07:36:35 INFO - Reading from file tmpfile_stdout 07:36:35 INFO - Output received: 07:36:35 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:35 INFO - Running post-action listener: _resource_record_post_action 07:36:35 INFO - [mozharness: 2016-10-28 14:36:35.411781Z] Finished install step (success) 07:36:35 INFO - [mozharness: 2016-10-28 14:36:35.412025Z] Running run-tests step. 07:36:35 INFO - Running pre-action listener: _resource_record_pre_action 07:36:35 INFO - Running main action method: run_tests 07:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:35 INFO - Python 2.7.3 07:36:35 INFO - Return code: 0 07:36:35 INFO - grabbing minidump binary from tooltool 07:36:35 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')]} 07:36:35 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 0x255cf60>, '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 0x255dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:35 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 07:36:35 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 07:36:35 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 07:36:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:35 INFO - Return code: 0 07:36:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 07:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 07:36:35 INFO - Using env: {'DISPLAY': ':0', 07:36:35 INFO - 'HOME': '/home/cltbld', 07:36:35 INFO - 'LANG': 'en_US.UTF-8', 07:36:35 INFO - 'LANGUAGE': 'en_US:en', 07:36:35 INFO - 'LOGNAME': 'cltbld', 07:36:35 INFO - 'MAIL': '/var/mail/cltbld', 07:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:35 INFO - 'MOZ_NO_REMOTE': '1', 07:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:35 INFO - 'NO_EM_RESTART': '1', 07:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:35 INFO - 'PWD': '/builds/slave/test', 07:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:35 INFO - 'SHELL': '/bin/bash', 07:36:35 INFO - 'SHLVL': '1', 07:36:35 INFO - 'TERM': 'linux', 07:36:35 INFO - 'TMOUT': '86400', 07:36:35 INFO - 'USER': 'cltbld', 07:36:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854', 07:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:35 INFO - '_': '/tools/buildbot/bin/python'} 07:36:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 07:36:35 INFO - mozversion application_buildid: 20161028061458 07:36:35 INFO - mozversion application_changeset: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a 07:36:35 INFO - mozversion application_display_name: Nightly 07:36:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:35 INFO - mozversion application_name: Firefox 07:36:35 INFO - mozversion application_remotingname: firefox 07:36:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:36:35 INFO - mozversion application_vendor: Mozilla 07:36:35 INFO - mozversion application_version: 52.0a1 07:36:35 INFO - mozversion platform_buildid: 20161028061458 07:36:35 INFO - mozversion platform_changeset: 1561c917ee27c3ea04bd69467e5b8c7c08102f2a 07:36:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:36:35 INFO - mozversion platform_version: 52.0a1 07:36:35 INFO - using testdate: 1477665395 07:36:35 INFO - actual date: 1477665395 07:36:35 INFO - starting webserver on 'localhost:33479' 07:36:35 INFO - SUITE-START | Running 2 tests 07:36:35 INFO - TEST-START | dromaeo_css 07:36:35 INFO - operating with platform_type : linux_ 07:36:35 INFO - Initialising browser for dromaeo_css test... 07:36:35 INFO - TEST-INFO | started process 5207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjF82Q6/profile http://localhost:33479/getInfo.html) 07:36:40 INFO - PROCESS | 5207 | __metrics Screen width/height:1600/1200 07:36:40 INFO - PROCESS | 5207 | colorDepth:24 07:36:40 INFO - PROCESS | 5207 | Browser inner width/height: 1024/697 07:36:40 INFO - PROCESS | 5207 | __metrics 07:36:40 INFO - PROCESS | 5207 | 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" 07:36:40 INFO - PROCESS | 5207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:41 INFO - PROCESS | 5207 | console.error: PushService: 07:36:41 INFO - PROCESS | 5207 | stateChangeProcessEnqueue: Error transitioning state 07:36:41 INFO - PROCESS | 5207 | UnknownError 07:36:41 INFO - TEST-INFO | 5207: exit 0 07:36:41 INFO - Browser initialized. 07:36:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:41 INFO - TEST-INFO | started process 5288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjF82Q6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:54 INFO - PROCESS | 5288 | RSS: Main: 173604864 07:36:54 INFO - PROCESS | 5288 | 07:37:45 INFO - PROCESS | 5288 | 1477665465074 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] 07:39:59 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33479/tests/dromaeo/cssquery-ext.html) 07:40:00 INFO - PROCESS | 5288 | RSS: Main: 277504000 07:40:00 INFO - PROCESS | 5288 | 07:43:03 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-ext.html (next: http://localhost:33479/tests/dromaeo/cssquery-jquery.html) 07:43:03 INFO - PROCESS | 5288 | RSS: Main: 277708800 07:43:03 INFO - PROCESS | 5288 | 07:46:06 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33479/tests/dromaeo/cssquery-mootools.html) 07:46:06 INFO - PROCESS | 5288 | RSS: Main: 217608192 07:46:06 INFO - PROCESS | 5288 | 07:49:09 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33479/tests/dromaeo/cssquery-prototype.html) 07:49:09 INFO - PROCESS | 5288 | RSS: Main: 218955776 07:49:09 INFO - PROCESS | 5288 | 07:52:12 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33479/tests/dromaeo/cssquery-yui.html) 07:52:13 INFO - PROCESS | 5288 | RSS: Main: 218071040 07:52:13 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | Cycle 1(1): loaded http://localhost:33479/tests/dromaeo/cssquery-yui.html (next: http://localhost:33479/tests/dromaeo/cssquery-dojo.html) 07:55:16 INFO - PROCESS | 5288 | RSS: Main: 304177152 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | __start_tp_report 07:55:16 INFO - PROCESS | 5288 | _x_x_mozilla_page_load 07:55:16 INFO - PROCESS | 5288 | _x_x_mozilla_page_load_details 07:55:16 INFO - PROCESS | 5288 | |i|pagename|runs| 07:55:16 INFO - PROCESS | 5288 | |0;dojo.html;2543.7710606045457;2564.3973666188454;2585.7284985076562;2600.3889086064773;2616.3328351270425;4483.820647174117;4550.044490656957;4611.538846115391;4618.7228766274;4634.304854271861;4576.359309696637;4581;4613.561711637389;4637.095766325568;4639.814407423699;4225.281702110633;4237.194932962742;4285.507166675826;4302.26861433557;4307.892302692442;3888.8833334999995;4251.914961700764;4315.719478233905;4340.848070317539;4385.627221686161;4171.541130475645;4336.371226172188;4340.522542520352;4407.603315701586;4449.110177964404;4223.556526564697;4228.6617070634275;4241.97879010603;4270.145970805851;4307.8492252771;4250.107477429743;4261.126469073833;4312.072904325585;4334.501532323791;4336.02439451121;4568.49746527885;4598.839040633595;4612.815487380501;4618.769061546909;4680.789364478606;4788.018456216468;4793.161196790583;4843.6851604645935;4847.660663753539;4918.631102667314;4825.2520859266515;4864.343313652647;4867.123917694814;4901.1177987962155;4919.975400123012;4540.364348991144;4555;4555.088982203572;4555.521670224612;4604.240300350405;4880.877978050577;4943.752812359367;4970.353853998957;4974.825881094217;5034.471380505068;4714.504976977368;4726.763661816895;4729.6689231754135;4812.807487700523;4815.15734746418;4808.855734327975;4812.422509298906;4815.855524334275;4816.8795780105775;4876;4761.95238047622;4768.094062128184;4776.617870570346;4827.903441931142;4831.202851529529;4697.436307643105;4698.201305778026;4752.239641657387;4812.590929770939;4816.060868130681;4109.650679692199;4115.279826030433;4116.341385378325;4116.629503344653;4118.217538667704;3586.5875424326537;3625.4018087015347;3629.0201645555553;3635.236600313911;3663.084228942764;4171.749695018248;4171.749695018309;4218.620324170839;4222.218889505451;4228.429162063082;4903.95096049035;4918.237673160595;4940.061388336205;4946.802127914915;5001.024800163933;4030.75815451068;4082.5509193988637;4129.359949207817;4159.646430053479;4191;4396.868093957187;4404.581564751344;4419.756913369732;4461.486929003141;4466;4576.496585375539;4609.101225261042;4612.100640375229;4658.836940707059;4670.439547254351;4692.976535117303;4897.314375987436;4899.510048995072;4903.289023091703;4907.067657145131;4489.753063581535;4560.33875088117;4563.315502674625;4566.041131362451;4566.88582785433;4776.808927642995;4783.497732738012;4787.16224660676;4787.952120478751;4789;4805.471398146131;4833.130036593447;4872.512748725099;4873.634477414279;4942.258661200849;4747.623189275071;4752.5485078917445;4753.9049219016115;4811.879703007313;4812.470628230962;4710.576048155683;4740.407449068866;4748.453927798348;4758.095961767253;4811.037792441456;4591.517890621437;4613.976930115328;4646.349511068521;4683.180443422456;4684.391029166187;4736.194846876108;4736.976315118402;4742;4781.402324709411;4804.711717296974;4599.103174880866;4656.324832899279;4656.3946686930485;4673.4625518064495;4710.26990816424 07:55:16 INFO - PROCESS | 5288 | |1;ext.html;553.8144721518291;566.8582854286431;569.2173261765074;570.3583468597827;577.8902008618364;23618.409539761513;41088.178236435255;42359.788201059026;42695.146097078075;42732.43605383679;39296.80351598238;39675.206495870065;39711;39754.60245397545;39847.40228896569;7599.0881094268625;7754.263344982218;7761.495502792301;7761.495502792329;7762.068551773795;7558.319751222389;7637.045369328834;7643.694252229904;7643.808904777397;7644.808879778022;7656.923430765704;7704.46068775186;7705.229477052306;7705.267999540063;7705.653245603933;7642.121156067068;7671.961640191819;7672.309492145734;7683.615819209017;7686.3466605338335;7600.771976840703;7666.578338191397;7669.9616501917135;7671;7672.654730537083;37374.15142820011;37542.812285938395;37696.62303376986;37754.244915101546;37761.244775104344;3027.2129246395875;3157.447446696842;3368.983155084209;3389.5932488101585;3676.485292059114;26944.865275673692;28753;28966.855165724246;29324.560131598042;29812.701872981208;3404.097914052778;3428.4857271409237;3439.8968030958863;3489.2498112905846;3604.0269127335737;251649;252775;255775;256205.71897140582;256785;53714.731426342616;54115;54171.729141354044;54179.72910135424;54218;60177.39822601806;61693.38306616966;61834.381656182864;61869.38130618636;67190;14540.636484087983;14967.625809354853;15530.1458419788;15530.534083977273;15544;11383.943080284545;11791.410429478492;11791.646250612495;11796.705082372837;11799.941000294944;18738.906305468387;18959.146838392306;18983.33558325452;19018.33435829767;19039.714404283946;7445.292697193758;7647.57938313387;7663.31030207284;7685;7721.498102623312;700.0154561817203;829.4318391901567;912.166693991918;951.8714973478492;963.9951800240954;23978.88010559936;25756.613650795254;26339.604905926426;26541.734582653928;26883.462330753275;895.9865602015975;903.9819203615891;916.3402350307767;918.6555041859302;955.6607404371487;12973.221606703439;13687.794683079761;13831.239281839595;13886.513972010931;14244.715105698035;380486;383357;385189;385955;386128;47214.76392618015;47766.761166193945;47781.52218477771;47796.522034779904;47800.28299575509;937.0254934867797;971.8056388722284;999.6900960702205;1040.9375437473775;1090.7491277006334;26459.206223813315;27411.588826168023;27856.16431507058;28007.719922801327;28858.71141288644;34014.65985340115;34240.48639270363;34280.657193427745;34297.65702342945;34300.62797488073;294274;295218;295553;295979;297381;30614.84692576523;31438.37123257568;35147.29705405826;35937.46093808542;36514.45228321524;39702.404463932486;39713.80143099266;40112;41064.384034238916;41252.793736031126;34765.65234347725;34794;35060.824695876356;35096.824515877255;35385.64614353824;34542.65457345495;34629.30741385108;34656.133596660286;34812.82593587016;34830.65169348376;34188.82905585456;34560.82719586486;34694.30611387808;34885;35120.12199695028;29755.702442975293;31985.36029279355;32028.839855800572;32167.356652867278;32350.514742279356;24652.50694986126;24705.25884223476;24714;25193.87403062973;25213.495730084927 07:55:16 INFO - PROCESS | 5288 | |2;jquery.html;339.2282557182408;367.0877868496785;370.9295233905557;371.48734746050457;390.33253137135495;12290.692732681677;12399.256044637317;13181.868181318196;14201.85798142021;17114.828851711478;16453.588660283498;16587.253573589187;17134.22895969681;17250.654986900256;17263.82736172638;4820.686655367407;5153.2785410042625;5422.9728851355885;5446;5500.4499550045075;3393.9660603394022;5394.78420863167;5432.565394768409;5435.456454354572;5446.91829622556;3582.1760994971173;3589.0130214191176;3635.4365073413665;5923.555733320019;5959.910601340984;5674.858128546778;5998.55010874184;6002.819915402545;6003.0695242237525;6011.849703757397;5313.9734301328635;5341.305630268079;5342.091844386464;5343.064963631349;5344.946550534522;11973.40132993347;12051.517939282507;12179.147459677826;12259.203151795105;12341.259524428473;1667.7665126882246;1678.8656907447375;1749.0904729540696;1872.2323847222574;2215.014318628211;8892.59983300753;9075.954620226856;9130.223930965876;9565.952170239174;9776.120149186607;1641.1302009934755;1644.8355164483576;1693.6104695919885;1728.8530474909649;1750.553608829753;63230.62539684132;66866;67801.66099169472;69264;70369.2963070373;9330.860037099448;9816.705498835046;9968.918502924309;10018.148457381058;10111.090001899864;13787.172769633855;13821.170729756246;13832.654183645289;13839.377228024763;13845.961552883373;6699.899501507482;7294.708211671474;7337;7364.374028207555;7533.886991695129;6934.16789985205;6935.791926242221;7112.751053713198;7205.71177152908;7266.418686505067;4255.936160957588;4328.8268469260875;4333.501647310537;4457.576530229623;4465.665075119379;1830.688782906909;1861.5439217391827;1864.2729335559143;1906.742589750366;1920.5102698811713;735.4888352595002;789.3409003482042;796.3987189671876;820.6307161777105;915.8946721127022;16099.275532601061;16212.432564860173;16557.503274901774;16619;17409.129543522773;782.8669126248551;795.6459375577928;798.648594618366;845.5434065604628;880.7225723896952;8857.335699822539;9134.954325228331;9167.587458564381;9678.225741940629;10229.816037993358;359898;366446;371135;372015;373261;75023;76976;77274.6136269315;78326;79773;898.5327629632554;899.4198741811495;936.6674830435234;937.7983733497331;938.6620816506053;15140.772888406462;15184.468543601362;15534.533963981099;16001.519954401387;16105.67788644244;36661.63338366582;37099;37251.62748372481;37838.810805945795;37844.810775945945;47579.76210118927;50671.49328506668;50742.49257507525;51323.48676513336;52570.21144682756;6900.447964162755;7330.413566914741;7563.470557060953;7605.733799316998;7681.884771728317;9410.764730881509;11119.499622517167;11190.32858028521;11555.422228888354;11700.180987330805;9656.95171524138;9984.950075249577;10079.34484258521;10300.330478518872;10542.894571054498;4374.475062992461;4935.925961110658;9766.951165244129;10246.002029604155;10254;9621.374610650286;9803;9850.753731156492;9936.801263974825;10134.147497393331;6475.708593113415;7412.221716719667;7454.701811927463;7582.090149182133;7839.9216007839195;9981.850272246067;10514.894851051391;10519.368837869752;10590.735231618963;10889.074428673652 07:55:16 INFO - PROCESS | 5288 | |3;mootools.html;1242.9627111186667;1333.200079952029;1376.6214291069957;1430.8283006039276;1684.528332067021;6158.168647232622;6873.27830577789;7159.069320988264;7164.462665300104;7321.084864391951;7216.819579510515;7303.379212766908;7309.6345182740915;7310.561366318025;7311.926880731205;2082.3232449453913;2086.54096098858;2094.2670065477114;2101.2120454829437;2105.7999490048496;2025.3721346382595;2025.4531276555322;2028.7464066991627;2065.029436165;2073.170731707314;2038.021749560212;2065.834733221339;2080.459080639037;2081.739782527184;2084.6977188307687;2038.4292398128473;2049.5388537579;2052.158614967856;2054.8356131509445;2057.1565658080117;2029.7970202979732;2046.6623007203793;2073.419442556087;2073.9274125405536;2076.4186027912056;7194.460415468809;7232.457565682595;7276.527025743309;7285.41716662671;7297.963510182415;4165.271077561415;4327.826886924519;4330.805113769888;4377.168338015798;4398.780060996937;2630.9605355919675;2845.815022023562;2853.1155341843887;2859.4281143771327;2875.468038412879;897.5736525150567;901.3014913442134;903.5572569440992;911.8541033434618;925.9351845370827;9060;9074.546272686406;9094.636214551476;9113.58988845497;9138.543072846398;3486.163320802989;3625.6736893679695;3691.298653255873;3713.33160031197;3714.1086139326367;7697.846043079219;7699.846003079907;7711.383089352838;7713.537187768752;7717.112532058773;4311.568843115663;4318.481782186158;4322.416473776;4323.610875021263;4325.935110973338;3389.1018879996823;3477.634848340888;3581.2479379330634;4001.47980762499;4067.4102255173425;2939.3680358722977;3241.8865339712997;3256.886008989674;3271.8364081795817;3296.044147197334;947.190152419685;987.3828856964398;987.6247026130025;998.4857798233916;1020.4642562654666;753.593059747741;784.6547519091581;792.4334101117729;799.2846402469874;816.2572059425894;4678.274867395491;4735.479097299294;4749.2876068589985;4827.106985207678;5038.722870242099;375.6224993881187;380.3875760026355;386.16010177863035;392.8860630417147;396.3321802762355;3117;3210.871565137415;3228.5480032795426;3259.2340799912004;3345.9498107528407;8206.548639824867;8644.610992505352;8666.653333866574;8745.956270218736;8757.386982911263;8509.361797865062;8684;8707.782305442415;8717.956410217908;8719.346049046348;6722.159730033746;6780.220274668476;6886.965565172142;6892.345227203407;6892.448604111659;4731.503192164773;4745;4754.667173297836;4822.204336284473;5004.4495105537635;7830.569318687299;7904.960475197818;7984.041914970008;8006.359491240803;8052.637631306488;7817.960910195413;8135.145809690134;8174.386920980831;8221.095679475373;8231.46495477792;5050.898982020412;5241.187615919539;5637.943620563742;5779.913301300568;5800.535957123504;6743.35938085881;6805.421539169226;6808.353206445379;6808.9659551701925;6811.693473793592;6005.729742161526;6124.663143527148;6184.567080304336;6196.969015154896;6215.471684906834;5956.523478121827;6055.1522786809;6200.503959683124;6229.750809967551;6278.6546739929745;5624.578156638187;5701.885962280814;5716.228309178207;5717.542596592346;5731.570132240182;4121.855735049259;4174.519930208065;4272.209641216385;4294.01237715321;4344.478662560513;4136.276151673505;4184.121334519663;4241.278982572909;4270.081932384553;4350.0647360817575 07:55:16 INFO - PROCESS | 5288 | |4;prototype.html;290.43510372325824;297.331005238214;302.90198032133515;303.64625211628453;304.8765250073721;4719.834805781798;4729.219678753002;4757.881052973673;4768.807798050488;4773.665843390964;4720.858374248769;4724.936554563073;4732.337472753818;4732.503087175849;4740.31265466508;3563.7149028077692;3629.745917785756;3679.816009199543;3755.8309876055505;3756.140710348381;3700.611435799243;3720.9069773255615;3722.9255414891686;3723.720720945926;3730.3586421974246;3671.834767435472;3672.3022625701165;3677.356462619031;3679.208970071434;3689.8893033209047;3504.281622267429;3632.6730594246646;3637.9818100909592;3694.5935947045937;3707.94438083429;3319.5850518685165;3324.8670053197843;3328.5839270091237;3331.566896303489;3341.5154802553493;4576.244919588264;4583.954160458419;4590.750532239179;4593.081383723235;4603.884902877421;4184.727992680466;4238.491381034265;4241.787910604488;4244.19621660796;4250.341197114452;4882.072406242803;4896.4124305083615;4901.509849015106;4962.15643340633;4976.353074100344;3666.5966743658178;3671.9265614687824;3674.889753307405;3676.5955744868043;3681.8711345102793;5113.514216149497;5127.66670166438;5161.329027226437;5201.843944681666;5221.843344699665;3606.7294952878638;3713.814309284579;3728.3475391806323;3732.570754363283;3737.8691745788765;3776.905577360533;3779.7904670505172;3787.62123787619;3793.4067691569608;3793.5827059023486;4258.701890867609;4262.211490874198;4280.486341638961;4282.400463935051;4287.978560107242;4701;4872.244802055687;4976.835076741629;5007.198848184273;5014.423341315795;1282.5767496726057;1296.5656505070717;1297.6561211279018;1299.9025073119365;1307.7253776706807;824.1717074340249;839.471133186101;857.0872021297298;860.4020205956925;865.8311629232239;3854.9421758673643;4120.526139493936;4189.884108525236;4204.117135401539;4332.523422423531;5077.552897424216;5085.567726743194;5091.592672586185;5115.590752739772;5124.641275110781;4349.826006959749;4350.151720414552;4351.19502891966;4357.627347385564;4363.978180109079;2632.210336898961;2674;2686.4358484718036;2704.594310853388;2714.877830497632;4790.6944208496025;4819.614430845524;4821.228603423506;4838.903221935612;4843.346148270009;5250.396204436539;5254.710990895461;5271.182966640177;5276.472352764693;5278.683279003195;4536.342230376643;4806.134895718735;4839.201531747292;4847.418309802846;4854.5873600744335;5124.410692770379;5126.513640884243;5127.769250383667;5128.256402821645;5137.17805151174;5029.647924645386;5042.596592272683;5043.52086551777;5051.6716413433005;5058.873528161678;4651.837040739815;4766.547178018082;4812.590929771009;4819.180739274402;4839.249916262985;3594.256785458998;3612.1330880587943;3612.385894397906;3612.494250804837;3628.8911332660064;5082.949170508247;5085.516875896784;5093.261477085876;5098.898022039464;5119.539241468286;4747.430308363018;4913.287573301923;4923.753812309442;4937.975310123426;4976.527229913152;4923.931948581533;4929.16204245272;4930.408350997904;4945.826896058621;4951.6479672156875;4867.853964380933;4881.926771098365;4890.339804126397;4901.681390709592;4901.877453063702;4726.621870250303;4754.429468463806;4944.283078953604;4978.925316120333;4986.15235409974;4780.713157210578;4786.593139583035;4898.21628539432;4900.509949005071;4904.901901961869 07:55:16 INFO - PROCESS | 5288 | |5;yui.html;602.939706029397;605.9242594675666;609.890219760443;660.3627499463017;709.7161135545781;12227;13151.342432878366;13172.868271317297;13206.867931320683;13222.669433264173;12697.492100315976;12736.299503527302;12737.490500379974;12829.037822163351;12844.67888302793;608.6834845880162;629.1663545801808;763.0919206144698;779.7582749347721;780.8360244348679;792.188007292524;794.0986979777936;795.3358945280697;795.7851380127391;795.8328750962276;817.0277369929764;818.8239528501371;823.950562966224;825.3974598543067;825.8265764189528;634.1154090044386;648.8118445650803;794.4081659163902;813.6745301879237;821.5645707774889;605.1739375752111;611.3702886027398;611.7063809371526;611.7124951272895;611.7797592866565;11885.881141188564;11898.702532436671;11924.284542927366;11931.284122952564;11962;11043.72390690231;11116.833247501294;11194.552217911274;11324.433778311133;11593.6521904343;10806.243562950596;10897.727556811064;10973.177011724152;11123.666290011313;11150.665480035612;3726.9440958385644;3742.5321834770652;3757.887263382103;3890.863819766323;3937.9212415751526;46129.769351153365;47015.29477057847;47238;47585.524144758805;47783.761081194374;9487.857682134774;9527.190188833889;9604.711858644252;9659.71020869375;9719.659811906691;16163.191840407933;16215;16804.495865124067;17668;17801.376951806626;6505.837354066091;6560.901586476207;6582.868342633216;6658.933410665928;6681.331866813377;3496.265784185299;3630.6006339302658;3679.8528058877346;3698.9445158322646;3731.869384571527;2538.8095892808115;2635.248954048087;2645.629611854342;2680.5979103134687;2713.308106432847;444.0585957769485;448.41481866164315;448.6853519188808;456.5753848920536;460.39917907131513;509.55159459675247;520.7890804224295;583.3583058635467;610.5664977865765;616.7687117331001;7668.80827979305;7839.451238413257;7906;7941.1485429567765;8136.837263254702;514.6680391147689;575.1372940589116;600.495583709686;610.8992016317258;619.4982064527746;3723.94414083789;3959.544652365015;3968.940465893014;4096.860132262396;4144.233316836395;43980;44124.117517649465;44475.77762111169;64391.67804161043;70645.64677176684;59012.40987590069;61537.61554112504;62021.68989155025;62073;63520.68239658772;56191.43808561944;57238.42761572498;58391.99999999915;59808;59945.40054599398;7351.632418378953;7564.243575642392;7758.235428480683;7879.369650428067;7908.762737117896;38206.61793382031;39031.21937561176;39280.2143957125;40047.39928901127;40362;47658.523414766794;53705.73147134239;53856;54306.72846635742;55297.44702552923;9374.67188648394;9418.529073546159;9533.094356036165;9543.188828949616;9806.950965245129;10400.843987340348;10567.841482377924;10693.465326733787;10887.945560272148;10888.455577221266;9403.670871519738;9893.307468477138;9951.004899509991;10293.125084367613;10297.3821570706;10004.599816007278;10423.843642345522;10581.10060644823;10672.46637668129;10885.564577416815;8878.86681699762;9525.52372381392;9645.228381729585;9676.12914837668;9701.6119355225;7896;8190.221928916743;8298.958505207434;8361.498310101413;8454.704085356983;7984.600769961595;8227.341812655093;8764.56177191125;8918.37571369998;9035.45787252767 07:55:16 INFO - PROCESS | 5288 | __end_tp_report 07:55:16 INFO - PROCESS | 5288 | __start_cc_report 07:55:16 INFO - PROCESS | 5288 | _x_x_mozilla_cycle_collect,1127 07:55:16 INFO - PROCESS | 5288 | __end_cc_report 07:55:16 INFO - PROCESS | 5288 | __startTimestamp1477666516758__endTimestamp 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | ------- Summary: start ------- 07:55:16 INFO - PROCESS | 5288 | Number of tests: 6 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#0] dojo.html Cycles:165 Average:4511.35 Median:4634.30 stddev:455.16 (9.8%) stddev-sans-first:429.59 07:55:16 INFO - PROCESS | 5288 | Values: 2543.8 2564.4 2585.7 2600.4 2616.3 4483.8 4550.0 4611.5 4618.7 4634.3 4576.4 4581.0 4613.6 4637.1 4639.8 4225.3 4237.2 4285.5 4302.3 4307.9 3888.9 4251.9 4315.7 4340.8 4385.6 4171.5 4336.4 4340.5 4407.6 4449.1 4223.6 4228.7 4242.0 4270.1 4307.8 4250.1 4261.1 4312.1 4334.5 4336.0 4568.5 4598.8 4612.8 4618.8 4680.8 4788.0 4793.2 4843.7 4847.7 4918.6 4825.3 4864.3 4867.1 4901.1 4920.0 4540.4 4555.0 4555.1 4555.5 4604.2 4880.9 4943.8 4970.4 4974.8 5034.5 4714.5 4726.8 4729.7 4812.8 4815.2 4808.9 4812.4 4815.9 4816.9 4876.0 4762.0 4768.1 4776.6 4827.9 4831.2 4697.4 4698.2 4752.2 4812.6 4816.1 4109.7 4115.3 4116.3 4116.6 4118.2 3586.6 3625.4 3629.0 3635.2 3663.1 4171.7 4171.7 4218.6 4222.2 4228.4 4904.0 4918.2 4940.1 4946.8 5001.0 4030.8 4082.6 4129.4 4159.6 4191.0 4396.9 4404.6 4419.8 4461.5 4466.0 4576.5 4609.1 4612.1 4658.8 4670.4 4693.0 4897.3 4899.5 4903.3 4907.1 4489.8 4560.3 4563.3 4566.0 4566.9 4776.8 4783.5 4787.2 4788.0 4789.0 4805.5 4833.1 4872.5 4873.6 4942.3 4747.6 4752.5 4753.9 4811.9 4812.5 4710.6 4740.4 4748.5 4758.1 4811.0 4591.5 4614.0 4646.3 4683.2 4684.4 4736.2 4737.0 4742.0 4781.4 4804.7 4599.1 4656.3 4656.4 4673.5 4710.3 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#1] ext.html Cycles:180 Average:46729.75 Median:20059.24 stddev:83182.99 (414.7%) stddev-sans-first:83344.09 07:55:16 INFO - PROCESS | 5288 | Values: 553.8 566.9 569.2 570.4 577.9 23618.4 41088.2 42359.8 42695.1 42732.4 39296.8 39675.2 39711.0 39754.6 39847.4 7599.1 7754.3 7761.5 7761.5 7762.1 7558.3 7637.0 7643.7 7643.8 7644.8 7656.9 7704.5 7705.2 7705.3 7705.7 7642.1 7672.0 7672.3 7683.6 7686.3 7600.8 7666.6 7670.0 7671.0 7672.7 37374.2 37542.8 37696.6 37754.2 37761.2 3027.2 3157.4 3369.0 3389.6 3676.5 26944.9 28753.0 28966.9 29324.6 29812.7 3404.1 3428.5 3439.9 3489.2 3604.0 251649.0 252775.0 255775.0 256205.7 256785.0 53714.7 54115.0 54171.7 54179.7 54218.0 60177.4 61693.4 61834.4 61869.4 67190.0 14540.6 14967.6 15530.1 15530.5 15544.0 11383.9 11791.4 11791.6 11796.7 11799.9 18738.9 18959.1 18983.3 19018.3 19039.7 7445.3 7647.6 7663.3 7685.0 7721.5 700.0 829.4 912.2 951.9 964.0 23978.9 25756.6 26339.6 26541.7 26883.5 896.0 904.0 916.3 918.7 955.7 12973.2 13687.8 13831.2 13886.5 14244.7 380486.0 383357.0 385189.0 385955.0 386128.0 47214.8 47766.8 47781.5 47796.5 47800.3 937.0 971.8 999.7 1040.9 1090.7 26459.2 27411.6 27856.2 28007.7 28858.7 34014.7 34240.5 34280.7 34297.7 34300.6 294274.0 295218.0 295553.0 295979.0 297381.0 30614.8 31438.4 35147.3 35937.5 36514.5 39702.4 39713.8 40112.0 41064.4 41252.8 34765.7 34794.0 35060.8 35096.8 35385.6 34542.7 34629.3 34656.1 34812.8 34830.7 34188.8 34560.8 34694.3 34885.0 35120.1 29755.7 31985.4 32028.8 32167.4 32350.5 24652.5 24705.3 24714.0 25193.9 25213.5 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#2] jquery.html Cycles:180 Average:23228.63 Median:50706.99 stddev:61054.10 (120.4%) stddev-sans-first:61201.18 07:55:16 INFO - PROCESS | 5288 | Values: 339.2 367.1 370.9 371.5 390.3 12290.7 12399.3 13181.9 14201.9 17114.8 16453.6 16587.3 17134.2 17250.7 17263.8 4820.7 5153.3 5423.0 5446.0 5500.4 3394.0 5394.8 5432.6 5435.5 5446.9 3582.2 3589.0 3635.4 5923.6 5959.9 5674.9 5998.6 6002.8 6003.1 6011.8 5314.0 5341.3 5342.1 5343.1 5344.9 11973.4 12051.5 12179.1 12259.2 12341.3 1667.8 1678.9 1749.1 1872.2 2215.0 8892.6 9076.0 9130.2 9566.0 9776.1 1641.1 1644.8 1693.6 1728.9 1750.6 63230.6 66866.0 67801.7 69264.0 70369.3 9330.9 9816.7 9968.9 10018.1 10111.1 13787.2 13821.2 13832.7 13839.4 13846.0 6699.9 7294.7 7337.0 7364.4 7533.9 6934.2 6935.8 7112.8 7205.7 7266.4 4255.9 4328.8 4333.5 4457.6 4465.7 1830.7 1861.5 1864.3 1906.7 1920.5 735.5 789.3 796.4 820.6 915.9 16099.3 16212.4 16557.5 16619.0 17409.1 782.9 795.6 798.6 845.5 880.7 8857.3 9135.0 9167.6 9678.2 10229.8 359898.0 366446.0 371135.0 372015.0 373261.0 75023.0 76976.0 77274.6 78326.0 79773.0 898.5 899.4 936.7 937.8 938.7 15140.8 15184.5 15534.5 16001.5 16105.7 36661.6 37099.0 37251.6 37838.8 37844.8 47579.8 50671.5 50742.5 51323.5 52570.2 6900.4 7330.4 7563.5 7605.7 7681.9 9410.8 11119.5 11190.3 11555.4 11700.2 9657.0 9985.0 10079.3 10300.3 10542.9 4374.5 4935.9 9767.0 10246.0 10254.0 9621.4 9803.0 9850.8 9936.8 10134.1 6475.7 7412.2 7454.7 7582.1 7839.9 9981.9 10514.9 10519.4 10590.7 10889.1 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#3] mootools.html Cycles:180 Average:4635.73 Median:5044.81 stddev:2553.69 (50.6%) stddev-sans-first:2548.12 07:55:16 INFO - PROCESS | 5288 | Values: 1243.0 1333.2 1376.6 1430.8 1684.5 6158.2 6873.3 7159.1 7164.5 7321.1 7216.8 7303.4 7309.6 7310.6 7311.9 2082.3 2086.5 2094.3 2101.2 2105.8 2025.4 2025.5 2028.7 2065.0 2073.2 2038.0 2065.8 2080.5 2081.7 2084.7 2038.4 2049.5 2052.2 2054.8 2057.2 2029.8 2046.7 2073.4 2073.9 2076.4 7194.5 7232.5 7276.5 7285.4 7298.0 4165.3 4327.8 4330.8 4377.2 4398.8 2631.0 2845.8 2853.1 2859.4 2875.5 897.6 901.3 903.6 911.9 925.9 9060.0 9074.5 9094.6 9113.6 9138.5 3486.2 3625.7 3691.3 3713.3 3714.1 7697.8 7699.8 7711.4 7713.5 7717.1 4311.6 4318.5 4322.4 4323.6 4325.9 3389.1 3477.6 3581.2 4001.5 4067.4 2939.4 3241.9 3256.9 3271.8 3296.0 947.2 987.4 987.6 998.5 1020.5 753.6 784.7 792.4 799.3 816.3 4678.3 4735.5 4749.3 4827.1 5038.7 375.6 380.4 386.2 392.9 396.3 3117.0 3210.9 3228.5 3259.2 3345.9 8206.5 8644.6 8666.7 8746.0 8757.4 8509.4 8684.0 8707.8 8718.0 8719.3 6722.2 6780.2 6887.0 6892.3 6892.4 4731.5 4745.0 4754.7 4822.2 5004.4 7830.6 7905.0 7984.0 8006.4 8052.6 7818.0 8135.1 8174.4 8221.1 8231.5 5050.9 5241.2 5637.9 5779.9 5800.5 6743.4 6805.4 6808.4 6809.0 6811.7 6005.7 6124.7 6184.6 6197.0 6215.5 5956.5 6055.2 6200.5 6229.8 6278.7 5624.6 5701.9 5716.2 5717.5 5731.6 4121.9 4174.5 4272.2 4294.0 4344.5 4136.3 4184.1 4241.3 4270.1 4350.1 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#4] prototype.html Cycles:180 Average:4124.68 Median:4725.78 stddev:1187.31 (25.1%) stddev-sans-first:1155.23 07:55:16 INFO - PROCESS | 5288 | Values: 290.4 297.3 302.9 303.6 304.9 4719.8 4729.2 4757.9 4768.8 4773.7 4720.9 4724.9 4732.3 4732.5 4740.3 3563.7 3629.7 3679.8 3755.8 3756.1 3700.6 3720.9 3722.9 3723.7 3730.4 3671.8 3672.3 3677.4 3679.2 3689.9 3504.3 3632.7 3638.0 3694.6 3707.9 3319.6 3324.9 3328.6 3331.6 3341.5 4576.2 4584.0 4590.8 4593.1 4603.9 4184.7 4238.5 4241.8 4244.2 4250.3 4882.1 4896.4 4901.5 4962.2 4976.4 3666.6 3671.9 3674.9 3676.6 3681.9 5113.5 5127.7 5161.3 5201.8 5221.8 3606.7 3713.8 3728.3 3732.6 3737.9 3776.9 3779.8 3787.6 3793.4 3793.6 4258.7 4262.2 4280.5 4282.4 4288.0 4701.0 4872.2 4976.8 5007.2 5014.4 1282.6 1296.6 1297.7 1299.9 1307.7 824.2 839.5 857.1 860.4 865.8 3854.9 4120.5 4189.9 4204.1 4332.5 5077.6 5085.6 5091.6 5115.6 5124.6 4349.8 4350.2 4351.2 4357.6 4364.0 2632.2 2674.0 2686.4 2704.6 2714.9 4790.7 4819.6 4821.2 4838.9 4843.3 5250.4 5254.7 5271.2 5276.5 5278.7 4536.3 4806.1 4839.2 4847.4 4854.6 5124.4 5126.5 5127.8 5128.3 5137.2 5029.6 5042.6 5043.5 5051.7 5058.9 4651.8 4766.5 4812.6 4819.2 4839.2 3594.3 3612.1 3612.4 3612.5 3628.9 5082.9 5085.5 5093.3 5098.9 5119.5 4747.4 4913.3 4923.8 4938.0 4976.5 4923.9 4929.2 4930.4 4945.8 4951.6 4867.9 4881.9 4890.3 4901.7 4901.9 4726.6 4754.4 4944.3 4978.9 4986.2 4780.7 4786.6 4898.2 4900.5 4904.9 07:55:16 INFO - PROCESS | 5288 | 07:55:16 INFO - PROCESS | 5288 | [#5] yui.html Cycles:180 Average:14128.94 Median:579.25 stddev:17979.06 (3103.9%) stddev-sans-first:18000.81 07:55:16 INFO - PROCESS | 5288 | Values: 602.9 605.9 609.9 660.4 709.7 12227.0 13151.3 13172.9 13206.9 13222.7 12697.5 12736.3 12737.5 12829.0 12844.7 608.7 629.2 763.1 779.8 780.8 792.2 794.1 795.3 795.8 795.8 817.0 818.8 824.0 825.4 825.8 634.1 648.8 794.4 813.7 821.6 605.2 611.4 611.7 611.7 611.8 11885.9 11898.7 11924.3 11931.3 11962.0 11043.7 11116.8 11194.6 11324.4 11593.7 10806.2 10897.7 10973.2 11123.7 11150.7 3726.9 3742.5 3757.9 3890.9 3937.9 46129.8 47015.3 47238.0 47585.5 47783.8 9487.9 9527.2 9604.7 9659.7 9719.7 16163.2 16215.0 16804.5 17668.0 17801.4 6505.8 6560.9 6582.9 6658.9 6681.3 3496.3 3630.6 3679.9 3698.9 3731.9 2538.8 2635.2 2645.6 2680.6 2713.3 444.1 448.4 448.7 456.6 460.4 509.6 520.8 583.4 610.6 616.8 7668.8 7839.5 7906.0 7941.1 8136.8 514.7 575.1 600.5 610.9 619.5 3723.9 3959.5 3968.9 4096.9 4144.2 43980.0 44124.1 44475.8 64391.7 70645.6 59012.4 61537.6 62021.7 62073.0 63520.7 56191.4 57238.4 58392.0 59808.0 59945.4 7351.6 7564.2 7758.2 7879.4 7908.8 38206.6 39031.2 39280.2 40047.4 40362.0 47658.5 53705.7 53856.0 54306.7 55297.4 9374.7 9418.5 9533.1 9543.2 9807.0 10400.8 10567.8 10693.5 10887.9 10888.5 9403.7 9893.3 9951.0 10293.1 10297.4 10004.6 10423.8 10581.1 10672.5 10885.6 8878.9 9525.5 9645.2 9676.1 9701.6 7896.0 8190.2 8299.0 8361.5 8454.7 7984.6 8227.3 8764.6 8918.4 9035.5 07:55:16 INFO - PROCESS | 5288 | -------- Summary: end -------- 07:55:16 INFO - PROCESS | 5288 | 07:55:17 INFO - TEST-INFO | 5288: exit 0 07:55:17 INFO - TEST-OK | dromaeo_css | took 1122055ms 07:55:17 INFO - TEST-START | kraken 07:55:17 INFO - operating with platform_type : linux_ 07:55:17 INFO - Initialising browser for kraken test... 07:55:17 INFO - TEST-INFO | started process 5597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6cfBPe/profile http://localhost:33479/getInfo.html) 07:55:22 INFO - PROCESS | 5597 | __metrics Screen width/height:1600/1200 07:55:22 INFO - PROCESS | 5597 | colorDepth:24 07:55:22 INFO - PROCESS | 5597 | Browser inner width/height: 1024/697 07:55:22 INFO - PROCESS | 5597 | __metrics 07:55:22 INFO - PROCESS | 5597 | 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" 07:55:22 INFO - PROCESS | 5597 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:23 INFO - PROCESS | 5597 | console.error: PushService: 07:55:23 INFO - PROCESS | 5597 | stateChangeProcessEnqueue: Error transitioning state 07:55:23 INFO - PROCESS | 5597 | UnknownError 07:55:24 INFO - TEST-INFO | 5597: exit 0 07:55:24 INFO - Browser initialized. 07:55:24 INFO - Running cycle 1/1 for kraken test... 07:55:24 INFO - TEST-INFO | started process 5677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6cfBPe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:36 INFO - PROCESS | 5677 | RSS: Main: 173371392 07:55:36 INFO - PROCESS | 5677 | 07:55:39 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33479/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:39 INFO - PROCESS | 5677 | RSS: Main: 230023168 07:55:39 INFO - PROCESS | 5677 | 07:55:42 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33479/tests/kraken/driver.html?testName=audio-dft) 07:55:43 INFO - PROCESS | 5677 | RSS: Main: 216772608 07:55:43 INFO - PROCESS | 5677 | 07:55:46 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33479/tests/kraken/driver.html?testName=audio-fft) 07:55:47 INFO - PROCESS | 5677 | RSS: Main: 298807296 07:55:47 INFO - PROCESS | 5677 | 07:55:49 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33479/tests/kraken/driver.html?testName=audio-oscillator) 07:55:50 INFO - PROCESS | 5677 | RSS: Main: 209420288 07:55:50 INFO - PROCESS | 5677 | 07:55:52 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:52 INFO - PROCESS | 5677 | RSS: Main: 213102592 07:55:52 INFO - PROCESS | 5677 | 07:55:56 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33479/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:56 INFO - PROCESS | 5677 | RSS: Main: 248877056 07:55:56 INFO - PROCESS | 5677 | 07:56:00 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33479/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:00 INFO - PROCESS | 5677 | RSS: Main: 248365056 07:56:00 INFO - PROCESS | 5677 | 07:56:03 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33479/tests/kraken/driver.html?testName=json-parse-financial) 07:56:04 INFO - PROCESS | 5677 | RSS: Main: 247517184 07:56:04 INFO - PROCESS | 5677 | 07:56:05 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:06 INFO - PROCESS | 5677 | RSS: Main: 209809408 07:56:06 INFO - PROCESS | 5677 | 07:56:08 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:08 INFO - PROCESS | 5677 | RSS: Main: 216211456 07:56:08 INFO - PROCESS | 5677 | 07:56:11 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:11 INFO - PROCESS | 5677 | RSS: Main: 226402304 07:56:11 INFO - PROCESS | 5677 | 07:56:14 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:15 INFO - PROCESS | 5677 | RSS: Main: 235483136 07:56:15 INFO - PROCESS | 5677 | 07:56:18 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:18 INFO - PROCESS | 5677 | RSS: Main: 231501824 07:56:18 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | Cycle 1(1): loaded http://localhost:33479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33479/tests/kraken/driver.html?testName=ai-astar) 07:56:20 INFO - PROCESS | 5677 | RSS: Main: 282181632 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | __start_tp_report 07:56:20 INFO - PROCESS | 5677 | _x_x_mozilla_page_load 07:56:20 INFO - PROCESS | 5677 | _x_x_mozilla_page_load_details 07:56:20 INFO - PROCESS | 5677 | |i|pagename|runs| 07:56:20 INFO - PROCESS | 5677 | |0;ai-astar;107;115;113;114;116;113;114;114;114;114 07:56:20 INFO - PROCESS | 5677 | |1;audio-beat-detection;153;138;127;171;128;128;127;127;166;127 07:56:20 INFO - PROCESS | 5677 | |2;audio-dft;162;163;162;162;162;160;161;161;163;161 07:56:20 INFO - PROCESS | 5677 | |3;audio-fft;75;76;77;111;77;77;75;77;103;76 07:56:20 INFO - PROCESS | 5677 | |4;audio-oscillator;85;84;121;84;85;84;107;84;84;125 07:56:20 INFO - PROCESS | 5677 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;120;118;118 07:56:20 INFO - PROCESS | 5677 | |6;imaging-darkroom;146;147;147;147;146;147;147;146;146;147 07:56:20 INFO - PROCESS | 5677 | |7;imaging-desaturate;85;84;85;85;84;84;85;84;85;84 07:56:20 INFO - PROCESS | 5677 | |8;json-parse-financial;62;62;62;71;63;62;62;63;64;63 07:56:20 INFO - PROCESS | 5677 | |9;json-stringify-tinderbox;67;67;67;67;68;67;67;67;67;68 07:56:20 INFO - PROCESS | 5677 | |10;stanford-crypto-aes;84;86;89;84;85;83;83;83;89;88 07:56:20 INFO - PROCESS | 5677 | |11;stanford-crypto-ccm;144;141;146;151;142;143;140;143;183;145 07:56:20 INFO - PROCESS | 5677 | |12;stanford-crypto-pbkdf2;183;181;180;185;184;175;176;177;173;176 07:56:20 INFO - PROCESS | 5677 | |13;stanford-crypto-sha256-iterative;70;71;71;70;71;71;71;70;70;70 07:56:20 INFO - PROCESS | 5677 | __end_tp_report 07:56:20 INFO - PROCESS | 5677 | __start_cc_report 07:56:20 INFO - PROCESS | 5677 | _x_x_mozilla_cycle_collect,1937 07:56:20 INFO - PROCESS | 5677 | __end_cc_report 07:56:20 INFO - PROCESS | 5677 | __startTimestamp1477666580925__endTimestamp 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | ------- Summary: start ------- 07:56:20 INFO - PROCESS | 5677 | Number of tests: 14 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:0.93 07:56:20 INFO - PROCESS | 5677 | Values: 107.0 115.0 113.0 114.0 116.0 113.0 114.0 114.0 114.0 114.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:133.00 stddev:17.54 (13.2%) stddev-sans-first:17.87 07:56:20 INFO - PROCESS | 5677 | Values: 153.0 138.0 127.0 171.0 128.0 128.0 127.0 127.0 166.0 127.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:56:20 INFO - PROCESS | 5677 | Values: 162.0 163.0 162.0 162.0 162.0 160.0 161.0 161.0 163.0 161.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:13.13 (17.2%) stddev-sans-first:13.65 07:56:20 INFO - PROCESS | 5677 | Values: 75.0 76.0 77.0 111.0 77.0 77.0 75.0 77.0 103.0 76.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:16.73 (19.9%) stddev-sans-first:17.41 07:56:20 INFO - PROCESS | 5677 | Values: 85.0 84.0 121.0 84.0 85.0 84.0 107.0 84.0 84.0 125.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 07:56:20 INFO - PROCESS | 5677 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 120.0 118.0 118.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:56:20 INFO - PROCESS | 5677 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:56:20 INFO - PROCESS | 5677 | Values: 85.0 84.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.76 (4.4%) stddev-sans-first:2.88 07:56:20 INFO - PROCESS | 5677 | Values: 62.0 62.0 62.0 71.0 63.0 62.0 62.0 63.0 64.0 63.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:56:20 INFO - PROCESS | 5677 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.46 (2.9%) stddev-sans-first:2.55 07:56:20 INFO - PROCESS | 5677 | Values: 84.0 86.0 89.0 84.0 85.0 83.0 83.0 83.0 89.0 88.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:144.50 stddev:12.74 (8.8%) stddev-sans-first:13.44 07:56:20 INFO - PROCESS | 5677 | Values: 144.0 141.0 146.0 151.0 142.0 143.0 140.0 143.0 183.0 145.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:180.50 stddev:4.16 (2.3%) stddev-sans-first:4.16 07:56:20 INFO - PROCESS | 5677 | Values: 183.0 181.0 180.0 185.0 184.0 175.0 176.0 177.0 173.0 176.0 07:56:20 INFO - PROCESS | 5677 | 07:56:20 INFO - PROCESS | 5677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 07:56:20 INFO - PROCESS | 5677 | Values: 70.0 71.0 71.0 70.0 71.0 71.0 71.0 70.0 70.0 70.0 07:56:20 INFO - PROCESS | 5677 | -------- Summary: end -------- 07:56:20 INFO - PROCESS | 5677 | 07:56:22 INFO - TEST-INFO | 5677: exit 0 07:56:22 INFO - TEST-OK | kraken | took 64547ms 07:56:22 INFO - SUITE-END | took 1186s 07:56:22 INFO - Completed test suite (00:19:46) 07:56:22 INFO - javascript benchmark 07:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.7710606045457, 2564.3973666188454, 2585.7284985076562, 2600.3889086064773, 2616.3328351270425, 4483.820647174117, 4550.044490656957, 4611.538846115391, 4618.7228766274, 4634.304854271861, 4576.359309696637, 4581.0, 4613.561711637389, 4637.095766325568, 4639.814407423699, 4225.281702110633, 4237.194932962742, 4285.507166675826, 4302.26861433557, 4307.892302692442, 3888.8833334999995, 4251.914961700764, 4315.719478233905, 4340.848070317539, 4385.627221686161, 4171.541130475645, 4336.371226172188, 4340.522542520352, 4407.603315701586, 4449.110177964404, 4223.556526564697, 4228.6617070634275, 4241.97879010603, 4270.145970805851, 4307.8492252771, 4250.107477429743, 4261.126469073833, 4312.072904325585, 4334.501532323791, 4336.02439451121, 4568.49746527885, 4598.839040633595, 4612.815487380501, 4618.769061546909, 4680.789364478606, 4788.018456216468, 4793.161196790583, 4843.6851604645935, 4847.660663753539, 4918.631102667314, 4825.2520859266515, 4864.343313652647, 4867.123917694814, 4901.1177987962155, 4919.975400123012, 4540.364348991144, 4555.0, 4555.088982203572, 4555.521670224612, 4604.240300350405, 4880.877978050577, 4943.752812359367, 4970.353853998957, 4974.825881094217, 5034.471380505068, 4714.504976977368, 4726.763661816895, 4729.6689231754135, 4812.807487700523, 4815.15734746418, 4808.855734327975, 4812.422509298906, 4815.855524334275, 4816.8795780105775, 4876.0, 4761.95238047622, 4768.094062128184, 4776.617870570346, 4827.903441931142, 4831.202851529529, 4697.436307643105, 4698.201305778026, 4752.239641657387, 4812.590929770939, 4816.060868130681, 4109.650679692199, 4115.279826030433, 4116.341385378325, 4116.629503344653, 4118.217538667704, 3586.5875424326537, 3625.4018087015347, 3629.0201645555553, 3635.236600313911, 3663.084228942764, 4171.749695018248, 4171.749695018309, 4218.620324170839, 4222.218889505451, 4228.429162063082, 4903.95096049035, 4918.237673160595, 4940.061388336205, 4946.802127914915, 5001.024800163933, 4030.75815451068, 4082.5509193988637, 4129.359949207817, 4159.646430053479, 4191.0, 4396.868093957187, 4404.581564751344, 4419.756913369732, 4461.486929003141, 4466.0, 4576.496585375539, 4609.101225261042, 4612.100640375229, 4658.836940707059, 4670.439547254351, 4692.976535117303, 4897.314375987436, 4899.510048995072, 4903.289023091703, 4907.067657145131, 4489.753063581535, 4560.33875088117, 4563.315502674625, 4566.041131362451, 4566.88582785433, 4776.808927642995, 4783.497732738012, 4787.16224660676, 4787.952120478751, 4789.0, 4805.471398146131, 4833.130036593447, 4872.512748725099, 4873.634477414279, 4942.258661200849, 4747.623189275071, 4752.5485078917445, 4753.9049219016115, 4811.879703007313, 4812.470628230962, 4710.576048155683, 4740.407449068866, 4748.453927798348, 4758.095961767253, 4811.037792441456, 4591.517890621437, 4613.976930115328, 4646.349511068521, 4683.180443422456, 4684.391029166187, 4736.194846876108, 4736.976315118402, 4742.0, 4781.402324709411, 4804.711717296974, 4599.103174880866, 4656.324832899279, 4656.3946686930485, 4673.4625518064495, 4710.26990816424], "value": 4483.306962009636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8144721518291, 566.8582854286431, 569.2173261765074, 570.3583468597827, 577.8902008618364, 23618.409539761513, 41088.178236435255, 42359.788201059026, 42695.146097078075, 42732.43605383679, 39296.80351598238, 39675.206495870065, 39711.0, 39754.60245397545, 39847.40228896569, 7599.0881094268625, 7754.263344982218, 7761.495502792301, 7761.495502792329, 7762.068551773795, 7558.319751222389, 7637.045369328834, 7643.694252229904, 7643.808904777397, 7644.808879778022, 7656.923430765704, 7704.46068775186, 7705.229477052306, 7705.267999540063, 7705.653245603933, 7642.121156067068, 7671.961640191819, 7672.309492145734, 7683.615819209017, 7686.3466605338335, 7600.771976840703, 7666.578338191397, 7669.9616501917135, 7671.0, 7672.654730537083, 37374.15142820011, 37542.812285938395, 37696.62303376986, 37754.244915101546, 37761.244775104344, 3027.2129246395875, 3157.447446696842, 3368.983155084209, 3389.5932488101585, 3676.485292059114, 26944.865275673692, 28753.0, 28966.855165724246, 29324.560131598042, 29812.701872981208, 3404.097914052778, 3428.4857271409237, 3439.8968030958863, 3489.2498112905846, 3604.0269127335737, 251649.0, 252775.0, 255775.0, 256205.71897140582, 256785.0, 53714.731426342616, 54115.0, 54171.729141354044, 54179.72910135424, 54218.0, 60177.39822601806, 61693.38306616966, 61834.381656182864, 61869.38130618636, 67190.0, 14540.636484087983, 14967.625809354853, 15530.1458419788, 15530.534083977273, 15544.0, 11383.943080284545, 11791.410429478492, 11791.646250612495, 11796.705082372837, 11799.941000294944, 18738.906305468387, 18959.146838392306, 18983.33558325452, 19018.33435829767, 19039.714404283946, 7445.292697193758, 7647.57938313387, 7663.31030207284, 7685.0, 7721.498102623312, 700.0154561817203, 829.4318391901567, 912.166693991918, 951.8714973478492, 963.9951800240954, 23978.88010559936, 25756.613650795254, 26339.604905926426, 26541.734582653928, 26883.462330753275, 895.9865602015975, 903.9819203615891, 916.3402350307767, 918.6555041859302, 955.6607404371487, 12973.221606703439, 13687.794683079761, 13831.239281839595, 13886.513972010931, 14244.715105698035, 380486.0, 383357.0, 385189.0, 385955.0, 386128.0, 47214.76392618015, 47766.761166193945, 47781.52218477771, 47796.522034779904, 47800.28299575509, 937.0254934867797, 971.8056388722284, 999.6900960702205, 1040.9375437473775, 1090.7491277006334, 26459.206223813315, 27411.588826168023, 27856.16431507058, 28007.719922801327, 28858.71141288644, 34014.65985340115, 34240.48639270363, 34280.657193427745, 34297.65702342945, 34300.62797488073, 294274.0, 295218.0, 295553.0, 295979.0, 297381.0, 30614.84692576523, 31438.37123257568, 35147.29705405826, 35937.46093808542, 36514.45228321524, 39702.404463932486, 39713.80143099266, 40112.0, 41064.384034238916, 41252.793736031126, 34765.65234347725, 34794.0, 35060.824695876356, 35096.824515877255, 35385.64614353824, 34542.65457345495, 34629.30741385108, 34656.133596660286, 34812.82593587016, 34830.65169348376, 34188.82905585456, 34560.82719586486, 34694.30611387808, 34885.0, 35120.12199695028, 29755.702442975293, 31985.36029279355, 32028.839855800572, 32167.356652867278, 32350.514742279356, 24652.50694986126, 24705.25884223476, 24714.0, 25193.87403062973, 25213.495730084927], "value": 17372.439431846404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2282557182408, 367.0877868496785, 370.9295233905557, 371.48734746050457, 390.33253137135495, 12290.692732681677, 12399.256044637317, 13181.868181318196, 14201.85798142021, 17114.828851711478, 16453.588660283498, 16587.253573589187, 17134.22895969681, 17250.654986900256, 17263.82736172638, 4820.686655367407, 5153.2785410042625, 5422.9728851355885, 5446.0, 5500.4499550045075, 3393.9660603394022, 5394.78420863167, 5432.565394768409, 5435.456454354572, 5446.91829622556, 3582.1760994971173, 3589.0130214191176, 3635.4365073413665, 5923.555733320019, 5959.910601340984, 5674.858128546778, 5998.55010874184, 6002.819915402545, 6003.0695242237525, 6011.849703757397, 5313.9734301328635, 5341.305630268079, 5342.091844386464, 5343.064963631349, 5344.946550534522, 11973.40132993347, 12051.517939282507, 12179.147459677826, 12259.203151795105, 12341.259524428473, 1667.7665126882246, 1678.8656907447375, 1749.0904729540696, 1872.2323847222574, 2215.014318628211, 8892.59983300753, 9075.954620226856, 9130.223930965876, 9565.952170239174, 9776.120149186607, 1641.1302009934755, 1644.8355164483576, 1693.6104695919885, 1728.8530474909649, 1750.553608829753, 63230.62539684132, 66866.0, 67801.66099169472, 69264.0, 70369.2963070373, 9330.860037099448, 9816.705498835046, 9968.918502924309, 10018.148457381058, 10111.090001899864, 13787.172769633855, 13821.170729756246, 13832.654183645289, 13839.377228024763, 13845.961552883373, 6699.899501507482, 7294.708211671474, 7337.0, 7364.374028207555, 7533.886991695129, 6934.16789985205, 6935.791926242221, 7112.751053713198, 7205.71177152908, 7266.418686505067, 4255.936160957588, 4328.8268469260875, 4333.501647310537, 4457.576530229623, 4465.665075119379, 1830.688782906909, 1861.5439217391827, 1864.2729335559143, 1906.742589750366, 1920.5102698811713, 735.4888352595002, 789.3409003482042, 796.3987189671876, 820.6307161777105, 915.8946721127022, 16099.275532601061, 16212.432564860173, 16557.503274901774, 16619.0, 17409.129543522773, 782.8669126248551, 795.6459375577928, 798.648594618366, 845.5434065604628, 880.7225723896952, 8857.335699822539, 9134.954325228331, 9167.587458564381, 9678.225741940629, 10229.816037993358, 359898.0, 366446.0, 371135.0, 372015.0, 373261.0, 75023.0, 76976.0, 77274.6136269315, 78326.0, 79773.0, 898.5327629632554, 899.4198741811495, 936.6674830435234, 937.7983733497331, 938.6620816506053, 15140.772888406462, 15184.468543601362, 15534.533963981099, 16001.519954401387, 16105.67788644244, 36661.63338366582, 37099.0, 37251.62748372481, 37838.810805945795, 37844.810775945945, 47579.76210118927, 50671.49328506668, 50742.49257507525, 51323.48676513336, 52570.21144682756, 6900.447964162755, 7330.413566914741, 7563.470557060953, 7605.733799316998, 7681.884771728317, 9410.764730881509, 11119.499622517167, 11190.32858028521, 11555.422228888354, 11700.180987330805, 9656.95171524138, 9984.950075249577, 10079.34484258521, 10300.330478518872, 10542.894571054498, 4374.475062992461, 4935.925961110658, 9766.951165244129, 10246.002029604155, 10254.0, 9621.374610650286, 9803.0, 9850.753731156492, 9936.801263974825, 10134.147497393331, 6475.708593113415, 7412.221716719667, 7454.701811927463, 7582.090149182133, 7839.9216007839195, 9981.850272246067, 10514.894851051391, 10519.368837869752, 10590.735231618963, 10889.074428673652], "value": 7869.874073565076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.9627111186667, 1333.200079952029, 1376.6214291069957, 1430.8283006039276, 1684.528332067021, 6158.168647232622, 6873.27830577789, 7159.069320988264, 7164.462665300104, 7321.084864391951, 7216.819579510515, 7303.379212766908, 7309.6345182740915, 7310.561366318025, 7311.926880731205, 2082.3232449453913, 2086.54096098858, 2094.2670065477114, 2101.2120454829437, 2105.7999490048496, 2025.3721346382595, 2025.4531276555322, 2028.7464066991627, 2065.029436165, 2073.170731707314, 2038.021749560212, 2065.834733221339, 2080.459080639037, 2081.739782527184, 2084.6977188307687, 2038.4292398128473, 2049.5388537579, 2052.158614967856, 2054.8356131509445, 2057.1565658080117, 2029.7970202979732, 2046.6623007203793, 2073.419442556087, 2073.9274125405536, 2076.4186027912056, 7194.460415468809, 7232.457565682595, 7276.527025743309, 7285.41716662671, 7297.963510182415, 4165.271077561415, 4327.826886924519, 4330.805113769888, 4377.168338015798, 4398.780060996937, 2630.9605355919675, 2845.815022023562, 2853.1155341843887, 2859.4281143771327, 2875.468038412879, 897.5736525150567, 901.3014913442134, 903.5572569440992, 911.8541033434618, 925.9351845370827, 9060.0, 9074.546272686406, 9094.636214551476, 9113.58988845497, 9138.543072846398, 3486.163320802989, 3625.6736893679695, 3691.298653255873, 3713.33160031197, 3714.1086139326367, 7697.846043079219, 7699.846003079907, 7711.383089352838, 7713.537187768752, 7717.112532058773, 4311.568843115663, 4318.481782186158, 4322.416473776, 4323.610875021263, 4325.935110973338, 3389.1018879996823, 3477.634848340888, 3581.2479379330634, 4001.47980762499, 4067.4102255173425, 2939.3680358722977, 3241.8865339712997, 3256.886008989674, 3271.8364081795817, 3296.044147197334, 947.190152419685, 987.3828856964398, 987.6247026130025, 998.4857798233916, 1020.4642562654666, 753.593059747741, 784.6547519091581, 792.4334101117729, 799.2846402469874, 816.2572059425894, 4678.274867395491, 4735.479097299294, 4749.2876068589985, 4827.106985207678, 5038.722870242099, 375.6224993881187, 380.3875760026355, 386.16010177863035, 392.8860630417147, 396.3321802762355, 3117.0, 3210.871565137415, 3228.5480032795426, 3259.2340799912004, 3345.9498107528407, 8206.548639824867, 8644.610992505352, 8666.653333866574, 8745.956270218736, 8757.386982911263, 8509.361797865062, 8684.0, 8707.782305442415, 8717.956410217908, 8719.346049046348, 6722.159730033746, 6780.220274668476, 6886.965565172142, 6892.345227203407, 6892.448604111659, 4731.503192164773, 4745.0, 4754.667173297836, 4822.204336284473, 5004.4495105537635, 7830.569318687299, 7904.960475197818, 7984.041914970008, 8006.359491240803, 8052.637631306488, 7817.960910195413, 8135.145809690134, 8174.386920980831, 8221.095679475373, 8231.46495477792, 5050.898982020412, 5241.187615919539, 5637.943620563742, 5779.913301300568, 5800.535957123504, 6743.35938085881, 6805.421539169226, 6808.353206445379, 6808.9659551701925, 6811.693473793592, 6005.729742161526, 6124.663143527148, 6184.567080304336, 6196.969015154896, 6215.471684906834, 5956.523478121827, 6055.1522786809, 6200.503959683124, 6229.750809967551, 6278.6546739929745, 5624.578156638187, 5701.885962280814, 5716.228309178207, 5717.542596592346, 5731.570132240182, 4121.855735049259, 4174.519930208065, 4272.209641216385, 4294.01237715321, 4344.478662560513, 4136.276151673505, 4184.121334519663, 4241.278982572909, 4270.081932384553, 4350.0647360817575], "value": 3705.7774222269777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.43510372325824, 297.331005238214, 302.90198032133515, 303.64625211628453, 304.8765250073721, 4719.834805781798, 4729.219678753002, 4757.881052973673, 4768.807798050488, 4773.665843390964, 4720.858374248769, 4724.936554563073, 4732.337472753818, 4732.503087175849, 4740.31265466508, 3563.7149028077692, 3629.745917785756, 3679.816009199543, 3755.8309876055505, 3756.140710348381, 3700.611435799243, 3720.9069773255615, 3722.9255414891686, 3723.720720945926, 3730.3586421974246, 3671.834767435472, 3672.3022625701165, 3677.356462619031, 3679.208970071434, 3689.8893033209047, 3504.281622267429, 3632.6730594246646, 3637.9818100909592, 3694.5935947045937, 3707.94438083429, 3319.5850518685165, 3324.8670053197843, 3328.5839270091237, 3331.566896303489, 3341.5154802553493, 4576.244919588264, 4583.954160458419, 4590.750532239179, 4593.081383723235, 4603.884902877421, 4184.727992680466, 4238.491381034265, 4241.787910604488, 4244.19621660796, 4250.341197114452, 4882.072406242803, 4896.4124305083615, 4901.509849015106, 4962.15643340633, 4976.353074100344, 3666.5966743658178, 3671.9265614687824, 3674.889753307405, 3676.5955744868043, 3681.8711345102793, 5113.514216149497, 5127.66670166438, 5161.329027226437, 5201.843944681666, 5221.843344699665, 3606.7294952878638, 3713.814309284579, 3728.3475391806323, 3732.570754363283, 3737.8691745788765, 3776.905577360533, 3779.7904670505172, 3787.62123787619, 3793.4067691569608, 3793.5827059023486, 4258.701890867609, 4262.211490874198, 4280.486341638961, 4282.400463935051, 4287.978560107242, 4701.0, 4872.244802055687, 4976.835076741629, 5007.198848184273, 5014.423341315795, 1282.5767496726057, 1296.5656505070717, 1297.6561211279018, 1299.9025073119365, 1307.7253776706807, 824.1717074340249, 839.471133186101, 857.0872021297298, 860.4020205956925, 865.8311629232239, 3854.9421758673643, 4120.526139493936, 4189.884108525236, 4204.117135401539, 4332.523422423531, 5077.552897424216, 5085.567726743194, 5091.592672586185, 5115.590752739772, 5124.641275110781, 4349.826006959749, 4350.151720414552, 4351.19502891966, 4357.627347385564, 4363.978180109079, 2632.210336898961, 2674.0, 2686.4358484718036, 2704.594310853388, 2714.877830497632, 4790.6944208496025, 4819.614430845524, 4821.228603423506, 4838.903221935612, 4843.346148270009, 5250.396204436539, 5254.710990895461, 5271.182966640177, 5276.472352764693, 5278.683279003195, 4536.342230376643, 4806.134895718735, 4839.201531747292, 4847.418309802846, 4854.5873600744335, 5124.410692770379, 5126.513640884243, 5127.769250383667, 5128.256402821645, 5137.17805151174, 5029.647924645386, 5042.596592272683, 5043.52086551777, 5051.6716413433005, 5058.873528161678, 4651.837040739815, 4766.547178018082, 4812.590929771009, 4819.180739274402, 4839.249916262985, 3594.256785458998, 3612.1330880587943, 3612.385894397906, 3612.494250804837, 3628.8911332660064, 5082.949170508247, 5085.516875896784, 5093.261477085876, 5098.898022039464, 5119.539241468286, 4747.430308363018, 4913.287573301923, 4923.753812309442, 4937.975310123426, 4976.527229913152, 4923.931948581533, 4929.16204245272, 4930.408350997904, 4945.826896058621, 4951.6479672156875, 4867.853964380933, 4881.926771098365, 4890.339804126397, 4901.681390709592, 4901.877453063702, 4726.621870250303, 4754.429468463806, 4944.283078953604, 4978.925316120333, 4986.15235409974, 4780.713157210578, 4786.593139583035, 4898.21628539432, 4900.509949005071, 4904.901901961869], "value": 3749.898459386379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.939706029397, 605.9242594675666, 609.890219760443, 660.3627499463017, 709.7161135545781, 12227.0, 13151.342432878366, 13172.868271317297, 13206.867931320683, 13222.669433264173, 12697.492100315976, 12736.299503527302, 12737.490500379974, 12829.037822163351, 12844.67888302793, 608.6834845880162, 629.1663545801808, 763.0919206144698, 779.7582749347721, 780.8360244348679, 792.188007292524, 794.0986979777936, 795.3358945280697, 795.7851380127391, 795.8328750962276, 817.0277369929764, 818.8239528501371, 823.950562966224, 825.3974598543067, 825.8265764189528, 634.1154090044386, 648.8118445650803, 794.4081659163902, 813.6745301879237, 821.5645707774889, 605.1739375752111, 611.3702886027398, 611.7063809371526, 611.7124951272895, 611.7797592866565, 11885.881141188564, 11898.702532436671, 11924.284542927366, 11931.284122952564, 11962.0, 11043.72390690231, 11116.833247501294, 11194.552217911274, 11324.433778311133, 11593.6521904343, 10806.243562950596, 10897.727556811064, 10973.177011724152, 11123.666290011313, 11150.665480035612, 3726.9440958385644, 3742.5321834770652, 3757.887263382103, 3890.863819766323, 3937.9212415751526, 46129.769351153365, 47015.29477057847, 47238.0, 47585.524144758805, 47783.761081194374, 9487.857682134774, 9527.190188833889, 9604.711858644252, 9659.71020869375, 9719.659811906691, 16163.191840407933, 16215.0, 16804.495865124067, 17668.0, 17801.376951806626, 6505.837354066091, 6560.901586476207, 6582.868342633216, 6658.933410665928, 6681.331866813377, 3496.265784185299, 3630.6006339302658, 3679.8528058877346, 3698.9445158322646, 3731.869384571527, 2538.8095892808115, 2635.248954048087, 2645.629611854342, 2680.5979103134687, 2713.308106432847, 444.0585957769485, 448.41481866164315, 448.6853519188808, 456.5753848920536, 460.39917907131513, 509.55159459675247, 520.7890804224295, 583.3583058635467, 610.5664977865765, 616.7687117331001, 7668.80827979305, 7839.451238413257, 7906.0, 7941.1485429567765, 8136.837263254702, 514.6680391147689, 575.1372940589116, 600.495583709686, 610.8992016317258, 619.4982064527746, 3723.94414083789, 3959.544652365015, 3968.940465893014, 4096.860132262396, 4144.233316836395, 43980.0, 44124.117517649465, 44475.77762111169, 64391.67804161043, 70645.64677176684, 59012.40987590069, 61537.61554112504, 62021.68989155025, 62073.0, 63520.68239658772, 56191.43808561944, 57238.42761572498, 58391.99999999915, 59808.0, 59945.40054599398, 7351.632418378953, 7564.243575642392, 7758.235428480683, 7879.369650428067, 7908.762737117896, 38206.61793382031, 39031.21937561176, 39280.2143957125, 40047.39928901127, 40362.0, 47658.523414766794, 53705.73147134239, 53856.0, 54306.72846635742, 55297.44702552923, 9374.67188648394, 9418.529073546159, 9533.094356036165, 9543.188828949616, 9806.950965245129, 10400.843987340348, 10567.841482377924, 10693.465326733787, 10887.945560272148, 10888.455577221266, 9403.670871519738, 9893.307468477138, 9951.004899509991, 10293.125084367613, 10297.3821570706, 10004.599816007278, 10423.843642345522, 10581.10060644823, 10672.46637668129, 10885.564577416815, 8878.86681699762, 9525.52372381392, 9645.228381729585, 9676.12914837668, 9701.6119355225, 7896.0, 8190.221928916743, 8298.958505207434, 8361.498310101413, 8454.704085356983, 7984.600769961595, 8227.341812655093, 8764.56177191125, 8918.37571369998, 9035.45787252767], "value": 5922.080775668406, "unit": "score"}], "name": "dromaeo_css", "value": 6078.678244845308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 113.0, 114.0, 116.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 138.0, 127.0, 171.0, 128.0, 128.0, 127.0, 127.0, 166.0, 127.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 111.0, 77.0, 77.0, 75.0, 77.0, 103.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 84.0, 107.0, 84.0, 84.0, 125.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 71.0, 63.0, 62.0, 62.0, 63.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 89.0, 84.0, 85.0, 83.0, 83.0, 83.0, 89.0, 88.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 146.0, 151.0, 142.0, 143.0, 140.0, 143.0, 183.0, 145.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 180.0, 185.0, 184.0, 175.0, 176.0, 177.0, 173.0, 176.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 70.0, 70.0, 70.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1553.1, "alertThreshold": 2.0}]} 07:56:22 INFO - Return code: 0 07:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:22 INFO - # TBPL SUCCESS # 07:56:22 INFO - Running post-action listener: _resource_record_post_action 07:56:22 INFO - [mozharness: 2016-10-28 14:56:22.710942Z] Finished run-tests step (success) 07:56:22 INFO - Running post-run listener: _resource_record_post_run 07:56:22 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 390909952; Read time: 48; Write time: 221352 07:56:22 INFO - TinderboxPrint: CPU usage
13.0% 07:56:22 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 48 07:56:22 INFO - TinderboxPrint: I/O write bytes / time
390,909,952 / 221,352 07:56:22 INFO - TinderboxPrint: CPU idle
8,348.7 (87.0%) 07:56:22 INFO - TinderboxPrint: CPU user
1,201.6 (12.5%) 07:56:22 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98844672; Read time: 0; Write time: 50116 07:56:22 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292065280; Read time: 32; Write time: 171236 07:56:23 INFO - Running post-run listener: _upload_blobber_files 07:56:23 INFO - Blob upload gear active. 07:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:23 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 07:56:23 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:23 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:26 INFO - (blobuploader) - INFO - Done attempting. 07:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:27 INFO - (blobuploader) - INFO - Done attempting. 07:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:28 INFO - (blobuploader) - INFO - Done attempting. 07:56:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:28 INFO - Return code: 0 07:56:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e3305dacbf5b3f6ac84732f3af67c45369bfa42b60bbe82bbe3952845aa9f954931be4b83ae3be13b7e566e4b21fafff4a043c9bc2906d3bd8cf653e6764afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c76c12a20e05124cad267464c0abc303c744bda40803e8b1d6d287292ab0ca9a6b53b7eb9129d8e7fc84612314491f1e1a555f9b7e04fb18f960df976547624b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea2db6630e7b8a00b124e84253869c178604e92ec72e2f54b221f618b7ee85125d304da218c979fa4bda4920b76eaf62c0061aab7c40a492b9986e45ac78b69c"} 07:56:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:28 INFO - Contents: 07:56:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e3305dacbf5b3f6ac84732f3af67c45369bfa42b60bbe82bbe3952845aa9f954931be4b83ae3be13b7e566e4b21fafff4a043c9bc2906d3bd8cf653e6764afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c76c12a20e05124cad267464c0abc303c744bda40803e8b1d6d287292ab0ca9a6b53b7eb9129d8e7fc84612314491f1e1a555f9b7e04fb18f960df976547624b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea2db6630e7b8a00b124e84253869c178604e92ec72e2f54b221f618b7ee85125d304da218c979fa4bda4920b76eaf62c0061aab7c40a492b9986e45ac78b69c"} 07:56:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:28 INFO - Copying logs to upload dir... 07:56:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.993878 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-28 07:56:28.536637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 07:56:28.539740) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e3305dacbf5b3f6ac84732f3af67c45369bfa42b60bbe82bbe3952845aa9f954931be4b83ae3be13b7e566e4b21fafff4a043c9bc2906d3bd8cf653e6764afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c76c12a20e05124cad267464c0abc303c744bda40803e8b1d6d287292ab0ca9a6b53b7eb9129d8e7fc84612314491f1e1a555f9b7e04fb18f960df976547624b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea2db6630e7b8a00b124e84253869c178604e92ec72e2f54b221f618b7ee85125d304da218c979fa4bda4920b76eaf62c0061aab7c40a492b9986e45ac78b69c"} build_url:https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/Hlg0WsSMR_aHiusa_Upn_Q/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/Firefox-Non-PGO/sha512/2e3305dacbf5b3f6ac84732f3af67c45369bfa42b60bbe82bbe3952845aa9f954931be4b83ae3be13b7e566e4b21fafff4a043c9bc2906d3bd8cf653e6764afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c76c12a20e05124cad267464c0abc303c744bda40803e8b1d6d287292ab0ca9a6b53b7eb9129d8e7fc84612314491f1e1a555f9b7e04fb18f960df976547624b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea2db6630e7b8a00b124e84253869c178604e92ec72e2f54b221f618b7ee85125d304da218c979fa4bda4920b76eaf62c0061aab7c40a492b9986e45ac78b69c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 07:56:28.565157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:56:28.565500) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477663659.544611-608386854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 07:56:28.648895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 07:56:28.649215) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 07:56:28.649542) ========= ========= Total master_lag: 0.17 =========