builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1483116785.77 results: success (0) buildid: 20161230070824 builduid: 5d262c84894d4c6aa971a1ef00a9f0e0 revision: 4fc37724722145c3664a6db039748e9dc3c55451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.770937) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.771393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.771667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.785858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.786128) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 08:53:05-- 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% 68.5M=0s 2016-12-30 08:53:05 (68.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.898365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.899082) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021853 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.948909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:05.949275) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4fc37724722145c3664a6db039748e9dc3c55451 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4fc37724722145c3664a6db039748e9dc3c55451 --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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 08:53:06,085 truncating revision to first 12 chars 2016-12-30 08:53:06,085 Setting DEBUG logging. 2016-12-30 08:53:06,085 attempt 1/10 2016-12-30 08:53:06,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4fc377247221?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 08:53:06,382 unpacking tar archive at: mozilla-aurora-4fc377247221/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:06.561293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:06.561619) ========= script_repo_revision: 4fc37724722145c3664a6db039748e9dc3c55451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:06.562052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:06.562317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 08:53:06.572733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-30 08:53:06.573054) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:06 INFO - MultiFileLogger online at 20161230 08:53:06 in /builds/slave/test 08:53:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:53:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:06 INFO - {'append_to_log': False, 08:53:06 INFO - 'base_work_dir': '/builds/slave/test', 08:53:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:53:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:06 INFO - 'branch': 'Mozilla-Aurora', 08:53:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:06 INFO - 'config_files': ('talos/linux_config.py',), 08:53:06 INFO - 'default_actions': ('clobber', 08:53:06 INFO - 'read-buildbot-config', 08:53:06 INFO - 'download-and-extract', 08:53:06 INFO - 'populate-webroot', 08:53:06 INFO - 'create-virtualenv', 08:53:06 INFO - 'install', 08:53:06 INFO - 'run-tests'), 08:53:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:06 INFO - 'download_minidump_stackwalk': True, 08:53:06 INFO - 'download_symbols': 'ondemand', 08:53:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:06 INFO - 'installer_path': 'installer.exe', 08:53:06 INFO - 'log_level': 'info', 08:53:06 INFO - 'log_name': 'talos', 08:53:06 INFO - 'log_to_console': True, 08:53:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:06 INFO - 'opt_config_files': (), 08:53:06 INFO - 'pip_index': False, 08:53:06 INFO - 'sps_profile': False, 08:53:06 INFO - 'sps_profile_interval': 0, 08:53:06 INFO - 'suite': 'dromaeojs', 08:53:06 INFO - 'system_bits': '32', 08:53:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:06 INFO - 'title': 'talos-linux64-ix-022', 08:53:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:06 INFO - 'use_talos_json': True, 08:53:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:06 INFO - 'work_dir': 'build'} 08:53:06 INFO - [mozharness: 2016-12-30 16:53:06.800785Z] Running clobber step. 08:53:06 INFO - Running pre-action listener: _resource_record_pre_action 08:53:06 INFO - Running main action method: clobber 08:53:06 INFO - rmtree: /builds/slave/test/build 08:53:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:07 INFO - Running post-action listener: _resource_record_post_action 08:53:07 INFO - [mozharness: 2016-12-30 16:53:07.276132Z] Finished clobber step (success) 08:53:07 INFO - [mozharness: 2016-12-30 16:53:07.276231Z] Running read-buildbot-config step. 08:53:07 INFO - Running pre-action listener: _resource_record_pre_action 08:53:07 INFO - Running main action method: read_buildbot_config 08:53:07 INFO - Using buildbot properties: 08:53:07 INFO - { 08:53:07 INFO - "project": "", 08:53:07 INFO - "product": "firefox", 08:53:07 INFO - "script_repo_revision": "production", 08:53:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:53:07 INFO - "repository": "", 08:53:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:53:07 INFO - "buildid": "20161230070824", 08:53:07 INFO - "pgo_build": "True", 08:53:07 INFO - "basedir": "/builds/slave/test", 08:53:07 INFO - "buildnumber": 701, 08:53:07 INFO - "slavename": "talos-linux64-ix-022", 08:53:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:53:07 INFO - "platform": "ubuntu64_hw", 08:53:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:53:07 INFO - "branch": "mozilla-aurora", 08:53:07 INFO - "repo_path": "releases/mozilla-aurora", 08:53:07 INFO - "revision": "4fc37724722145c3664a6db039748e9dc3c55451", 08:53:07 INFO - "stage_platform": "linux64-pgo", 08:53:07 INFO - "builduid": "5d262c84894d4c6aa971a1ef00a9f0e0", 08:53:07 INFO - "slavebuilddir": "test" 08:53:07 INFO - } 08:53:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:53:07 INFO - Running post-action listener: _resource_record_post_action 08:53:07 INFO - [mozharness: 2016-12-30 16:53:07.278674Z] Finished read-buildbot-config step (success) 08:53:07 INFO - [mozharness: 2016-12-30 16:53:07.278761Z] Running download-and-extract step. 08:53:07 INFO - Running pre-action listener: _resource_record_pre_action 08:53:07 INFO - Running main action method: download_and_extract 08:53:07 INFO - mkdir: /builds/slave/test/build/tests 08:53: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')]} 08:53:07 INFO - trying https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:53:07 INFO - Downloaded 1361 bytes. 08:53:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:53:07 INFO - Using the following test package requirements: 08:53:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:53:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:53:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'jsshell-linux-x86_64.zip'], 08:53:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:53:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:53:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:53:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:53:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:53:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:07 INFO - Fetch https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:53:08 INFO - Http code: 200 08:53:08 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 08:53:08 INFO - x-amz-cf-id: FSQRhZSonis7prsgd_g9DKu3DW-y_mgY19yAINjIJdS0Z2LMJhgqQA== 08:53:08 INFO - x-amz-version-id: 9ZiqPv6GIxPpKYKU6WLu4O7ErpPeiGwq 08:53:08 INFO - Expected file size: 21941315 08:53:08 INFO - Obtained file size: 21941315 08:53:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:53:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:53:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:12 INFO - Fetch https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:53:13 INFO - Http code: 200 08:53:13 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 08:53:13 INFO - x-amz-cf-id: HfwNQVWVM1JWu6hl175vqL7uHJso1Y01cYflp-oCv3EI_-wY5OM4IQ== 08:53:13 INFO - x-amz-version-id: 9ZiqPv6GIxPpKYKU6WLu4O7ErpPeiGwq 08:53:13 INFO - Expected file size: 21941315 08:53:13 INFO - Obtained file size: 21941315 08:53:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:53:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:53:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:53:18 INFO - Http code: 200 08:53:18 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 08:53:18 INFO - x-amz-cf-id: krlLEgpRA6of1w2QYKtZZYgvIIL2OCDWNl4n8rRs5c_kvC3pnhTTnw== 08:53:18 INFO - x-amz-version-id: B5tkI_.uOPDWPwl58VrjwB8M9gn7JqUU 08:53:18 INFO - Expected file size: 14409038 08:53:18 INFO - Obtained file size: 14409038 08:53: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')]} 08:53:18 INFO - trying https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:53:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:53:19 INFO - Downloaded 64015688 bytes. 08:53:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:53:19 INFO - mkdir: /builds/slave/test/properties 08:53:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:19 INFO - Contents: 08:53:19 INFO - build_url:https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:53:20 INFO - Running post-action listener: _resource_record_post_action 08:53:20 INFO - Running post-action listener: set_extra_try_arguments 08:53:20 INFO - [mozharness: 2016-12-30 16:53:20.645835Z] Finished download-and-extract step (success) 08:53:20 INFO - [mozharness: 2016-12-30 16:53:20.646060Z] Running populate-webroot step. 08:53:20 INFO - Running pre-action listener: _resource_record_pre_action 08:53:20 INFO - Running main action method: populate_webroot 08:53:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:20 INFO - '--tppagecycles', 08:53:20 INFO - '7'], 08:53:20 INFO - 'tests': ['tsvgm']}}, 08:53:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['damp', 'tps']}, 08:53:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'tests': ['damp', 'tps']}, 08:53:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['dromaeo_dom']}, 08:53:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['basic_compositor_video']}, 08:53:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['a11yr', 08:53:20 INFO - 'ts_paint', 08:53:20 INFO - 'tpaint', 08:53:20 INFO - 'sessionrestore', 08:53:20 INFO - 'sessionrestore_no_auto_restore', 08:53:20 INFO - 'tabpaint']}, 08:53:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['tsvgx', 08:53:20 INFO - 'tsvgr_opacity', 08:53:20 INFO - 'tart', 08:53:20 INFO - 'tscrollx', 08:53:20 INFO - 'cart']}, 08:53:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:20 INFO - 'tsvgr_opacity', 08:53:20 INFO - 'tart', 08:53:20 INFO - 'tscrollx', 08:53:20 INFO - 'cart']}, 08:53:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'talos_options': ['--disable-e10s'], 08:53:20 INFO - 'tests': ['tp5o']}, 08:53:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'tests': ['tp5o']}, 08:53:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'talos_options': ['--disable-e10s', 08:53:20 INFO - '--xperf_path', 08:53:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:20 INFO - 'tests': ['tp5n']}, 08:53:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:20 INFO - 'talos_options': ['--xperf_path', 08:53:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:20 INFO - 'tests': ['tp5n']}}, 08:53:20 INFO - 'talos.zip': {'path': '', 08:53:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:20 INFO - Running post-action listener: _resource_record_post_action 08:53:20 INFO - [mozharness: 2016-12-30 16:53:20.666257Z] Finished populate-webroot step (success) 08:53:20 INFO - [mozharness: 2016-12-30 16:53:20.666345Z] Running create-virtualenv step. 08:53:20 INFO - Running pre-action listener: _resource_record_pre_action 08:53:20 INFO - Running main action method: create_virtualenv 08:53:20 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:20 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 08:53:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:20 INFO - Using real prefix '/usr' 08:53:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:23 INFO - Installing pip.................done. 08:53:23 INFO - Return code: 0 08:53:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:23 INFO - Reading from file tmpfile_stdout 08:53:23 INFO - Output received: 08:53:23 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) 08:53:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:23 INFO - Using env: {'DISPLAY': ':0', 08:53:23 INFO - 'HOME': '/home/cltbld', 08:53:23 INFO - 'LANG': 'en_US.UTF-8', 08:53:23 INFO - 'LANGUAGE': 'en_US:en', 08:53:23 INFO - 'LOGNAME': 'cltbld', 08:53:23 INFO - 'MAIL': '/var/mail/cltbld', 08:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:23 INFO - 'MOZ_NO_REMOTE': '1', 08:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:23 INFO - 'NO_EM_RESTART': '1', 08:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:23 INFO - 'PWD': '/builds/slave/test', 08:53:23 INFO - 'SHELL': '/bin/bash', 08:53:23 INFO - 'SHLVL': '1', 08:53:23 INFO - 'TERM': 'linux', 08:53:23 INFO - 'TMOUT': '86400', 08:53:23 INFO - 'USER': 'cltbld', 08:53:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:23 INFO - '_': '/tools/buildbot/bin/python'} 08:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:23 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 08:53:23 INFO - Cleaning up... 08:53:23 INFO - Return code: 0 08:53:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:23 INFO - Using env: {'DISPLAY': ':0', 08:53:23 INFO - 'HOME': '/home/cltbld', 08:53:23 INFO - 'LANG': 'en_US.UTF-8', 08:53:23 INFO - 'LANGUAGE': 'en_US:en', 08:53:23 INFO - 'LOGNAME': 'cltbld', 08:53:23 INFO - 'MAIL': '/var/mail/cltbld', 08:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:23 INFO - 'MOZ_NO_REMOTE': '1', 08:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:23 INFO - 'NO_EM_RESTART': '1', 08:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:23 INFO - 'PWD': '/builds/slave/test', 08:53:23 INFO - 'SHELL': '/bin/bash', 08:53:23 INFO - 'SHLVL': '1', 08:53:23 INFO - 'TERM': 'linux', 08:53:23 INFO - 'TMOUT': '86400', 08:53:23 INFO - 'USER': 'cltbld', 08:53:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:23 INFO - '_': '/tools/buildbot/bin/python'} 08:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:23 INFO - Downloading/unpacking psutil>=3.1.1 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:26 INFO - Installing collected packages: psutil 08:53:26 INFO - Running setup.py install for psutil 08:53:26 INFO - building 'psutil._psutil_linux' extension 08:53:26 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 08:53:26 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 08:53:26 INFO - building 'psutil._psutil_posix' extension 08:53:26 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 08:53:26 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 08:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:26 INFO - Successfully installed psutil 08:53:26 INFO - Cleaning up... 08:53:26 INFO - Return code: 0 08:53:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:26 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')]} 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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')]} 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:26 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 08:53:26 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 08:53:26 INFO - Using env: {'DISPLAY': ':0', 08:53:26 INFO - 'HOME': '/home/cltbld', 08:53:26 INFO - 'LANG': 'en_US.UTF-8', 08:53:26 INFO - 'LANGUAGE': 'en_US:en', 08:53:26 INFO - 'LOGNAME': 'cltbld', 08:53:26 INFO - 'MAIL': '/var/mail/cltbld', 08:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:26 INFO - 'MOZ_NO_REMOTE': '1', 08:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:26 INFO - 'NO_EM_RESTART': '1', 08:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:26 INFO - 'PWD': '/builds/slave/test', 08:53:26 INFO - 'SHELL': '/bin/bash', 08:53:26 INFO - 'SHLVL': '1', 08:53:26 INFO - 'TERM': 'linux', 08:53:26 INFO - 'TMOUT': '86400', 08:53:26 INFO - 'USER': 'cltbld', 08:53:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:26 INFO - '_': '/tools/buildbot/bin/python'} 08:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:28 INFO - Installing collected packages: mozsystemmonitor 08:53:28 INFO - Running setup.py install for mozsystemmonitor 08:53:28 INFO - Successfully installed mozsystemmonitor 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:29 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:29 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 08:53:29 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 08:53:29 INFO - Using env: {'DISPLAY': ':0', 08:53:29 INFO - 'HOME': '/home/cltbld', 08:53:29 INFO - 'LANG': 'en_US.UTF-8', 08:53:29 INFO - 'LANGUAGE': 'en_US:en', 08:53:29 INFO - 'LOGNAME': 'cltbld', 08:53:29 INFO - 'MAIL': '/var/mail/cltbld', 08:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:29 INFO - 'MOZ_NO_REMOTE': '1', 08:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:29 INFO - 'NO_EM_RESTART': '1', 08:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:29 INFO - 'PWD': '/builds/slave/test', 08:53:29 INFO - 'SHELL': '/bin/bash', 08:53:29 INFO - 'SHLVL': '1', 08:53:29 INFO - 'TERM': 'linux', 08:53:29 INFO - 'TMOUT': '86400', 08:53:29 INFO - 'USER': 'cltbld', 08:53:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:29 INFO - '_': '/tools/buildbot/bin/python'} 08:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:29 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 08:53:29 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 08:53:29 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 08:53:29 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 08:53:29 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 08:53:29 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 08:53:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:31 INFO - warning: no files found matching '*.txt' 08:53:31 INFO - no previously-included directories found matching 'build' 08:53:31 INFO - no previously-included directories found matching 'dist' 08:53:31 INFO - no previously-included directories found matching '.git*' 08:53:31 INFO - Installing collected packages: jsonschema, functools32 08:53:31 INFO - Running setup.py install for functools32 08:53:31 INFO - warning: no files found matching '*.txt' 08:53:31 INFO - no previously-included directories found matching 'build' 08:53:31 INFO - no previously-included directories found matching 'dist' 08:53:31 INFO - no previously-included directories found matching '.git*' 08:53:31 INFO - Successfully installed jsonschema functools32 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:31 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 08:53:31 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 08:53:31 INFO - Using env: {'DISPLAY': ':0', 08:53:31 INFO - 'HOME': '/home/cltbld', 08:53:31 INFO - 'LANG': 'en_US.UTF-8', 08:53:31 INFO - 'LANGUAGE': 'en_US:en', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MAIL': '/var/mail/cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SHLVL': '1', 08:53:31 INFO - 'TERM': 'linux', 08:53:31 INFO - 'TMOUT': '86400', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - '_': '/tools/buildbot/bin/python'} 08:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:31 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 08:53:31 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 08:53:31 INFO - Using env: {'DISPLAY': ':0', 08:53:31 INFO - 'HOME': '/home/cltbld', 08:53:31 INFO - 'LANG': 'en_US.UTF-8', 08:53:31 INFO - 'LANGUAGE': 'en_US:en', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MAIL': '/var/mail/cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SHLVL': '1', 08:53:31 INFO - 'TERM': 'linux', 08:53:31 INFO - 'TMOUT': '86400', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - '_': '/tools/buildbot/bin/python'} 08:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 INFO - Downloading docopt-0.6.1.tar.gz 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:34 INFO - Running setup.py install for blobuploader 08:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:35 INFO - Running setup.py install for requests 08:53:35 INFO - Running setup.py install for docopt 08:53:35 INFO - Successfully installed blobuploader requests docopt 08:53:35 INFO - Cleaning up... 08:53:35 INFO - Return code: 0 08:53:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:35 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:35 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 08:53:35 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 08:53:35 INFO - Using env: {'DISPLAY': ':0', 08:53:35 INFO - 'HOME': '/home/cltbld', 08:53:35 INFO - 'LANG': 'en_US.UTF-8', 08:53:35 INFO - 'LANGUAGE': 'en_US:en', 08:53:35 INFO - 'LOGNAME': 'cltbld', 08:53:35 INFO - 'MAIL': '/var/mail/cltbld', 08:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:35 INFO - 'MOZ_NO_REMOTE': '1', 08:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:35 INFO - 'NO_EM_RESTART': '1', 08:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:35 INFO - 'PWD': '/builds/slave/test', 08:53:35 INFO - 'SHELL': '/bin/bash', 08:53:35 INFO - 'SHLVL': '1', 08:53:35 INFO - 'TERM': 'linux', 08:53:35 INFO - 'TMOUT': '86400', 08:53:35 INFO - 'USER': 'cltbld', 08:53:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:35 INFO - '_': '/tools/buildbot/bin/python'} 08:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:35 INFO - Running setup.py (path:/tmp/pip-kLH_a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:35 INFO - Running setup.py (path:/tmp/pip-eywXga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:35 INFO - Running setup.py (path:/tmp/pip-ZSysk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:35 INFO - Running setup.py (path:/tmp/pip-_HkHtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:36 INFO - Running setup.py (path:/tmp/pip-cKsI4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:36 INFO - Running setup.py (path:/tmp/pip-wXdJN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:36 INFO - Running setup.py (path:/tmp/pip-DHufbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:36 INFO - Running setup.py (path:/tmp/pip-t5KFha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:36 INFO - Running setup.py (path:/tmp/pip-wFaovT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:36 INFO - Running setup.py (path:/tmp/pip-ZBZPAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:36 INFO - Running setup.py (path:/tmp/pip-PObbWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:36 INFO - Running setup.py (path:/tmp/pip-1zOZxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:36 INFO - Running setup.py (path:/tmp/pip-yuPN6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:36 INFO - Running setup.py (path:/tmp/pip-DOq2vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:36 INFO - Running setup.py (path:/tmp/pip-FgDm2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:36 INFO - Running setup.py (path:/tmp/pip-LTHDw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:36 INFO - Running setup.py (path:/tmp/pip-LbpZnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:36 INFO - Running setup.py install for manifestparser 08:53:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozcrash 08:53:37 INFO - Running setup.py install for mozdebug 08:53:37 INFO - Running setup.py install for mozdevice 08:53:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozfile 08:53:37 INFO - Running setup.py install for mozhttpd 08:53:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozinfo 08:53:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozInstall 08:53:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozleak 08:53:37 INFO - Running setup.py install for mozlog 08:53:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Running setup.py install for moznetwork 08:53:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Running setup.py install for mozprocess 08:53:38 INFO - Running setup.py install for mozprofile 08:53:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Running setup.py install for mozrunner 08:53:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Running setup.py install for mozscreenshot 08:53:38 INFO - Running setup.py install for moztest 08:53:38 INFO - Running setup.py install for mozversion 08:53:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:39 INFO - Running setup.py (path:/tmp/pip-B8zE4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:39 INFO - Running setup.py (path:/tmp/pip-RYB37X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:39 INFO - Running setup.py (path:/tmp/pip-mbBZsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:39 INFO - Running setup.py (path:/tmp/pip-eOr3Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:39 INFO - Running setup.py (path:/tmp/pip-BxIieS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 INFO - Running setup.py (path:/tmp/pip-G6LJ7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 INFO - Running setup.py (path:/tmp/pip-jKQ8Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 INFO - Running setup.py (path:/tmp/pip-IUpYte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:39 INFO - Running setup.py (path:/tmp/pip-6017TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:39 INFO - Running setup.py (path:/tmp/pip-07aJEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 INFO - Running setup.py (path:/tmp/pip-9x7tmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 INFO - Running setup.py (path:/tmp/pip-Zw43Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:39 INFO - Running setup.py (path:/tmp/pip-BekujQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:39 INFO - Running setup.py (path:/tmp/pip-R3LRBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:40 INFO - Running setup.py (path:/tmp/pip-hGZCfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:40 INFO - Running setup.py (path:/tmp/pip-0fT_wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:40 INFO - Running setup.py (path:/tmp/pip-IjFB4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:40 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)) 08:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:40 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)) 08:53:40 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)) 08:53:40 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)) 08:53:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:40 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 08:53:40 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 08:53:40 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 08:53:40 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 08:53:40 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 08:53:40 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 08:53:42 INFO - Downloading blessings-1.6.tar.gz 08:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:42 INFO - Installing collected packages: blessings 08:53:42 INFO - Running setup.py install for blessings 08:53:42 INFO - Successfully installed blessings 08:53:42 INFO - Cleaning up... 08:53:42 INFO - Return code: 0 08:53:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:42 INFO - Reading from file tmpfile_stdout 08:53:42 INFO - Current package versions: 08:53:42 INFO - argparse == 1.2.1 08:53:42 INFO - blessings == 1.6 08:53:42 INFO - blobuploader == 1.2.4 08:53:42 INFO - docopt == 0.6.1 08:53:42 INFO - functools32 == 3.2.3-2 08:53:42 INFO - jsonschema == 2.5.1 08:53:42 INFO - manifestparser == 1.1 08:53:42 INFO - mozInstall == 1.12 08:53:42 INFO - mozcrash == 1.0 08:53:42 INFO - mozdebug == 0.1 08:53:42 INFO - mozdevice == 0.48 08:53:42 INFO - mozfile == 1.2 08:53:42 INFO - mozhttpd == 0.7 08:53:42 INFO - mozinfo == 0.9 08:53:42 INFO - mozleak == 0.1 08:53:42 INFO - mozlog == 3.4 08:53:42 INFO - moznetwork == 0.27 08:53:42 INFO - mozprocess == 0.23 08:53:42 INFO - mozprofile == 0.28 08:53:42 INFO - mozrunner == 6.13 08:53:42 INFO - mozscreenshot == 0.1 08:53:42 INFO - mozsystemmonitor == 0.3 08:53:42 INFO - moztest == 0.7 08:53:42 INFO - mozversion == 1.4 08:53:42 INFO - psutil == 3.1.1 08:53:42 INFO - requests == 1.2.3 08:53:42 INFO - wsgiref == 0.1.2 08:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:42 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')]} 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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')]} 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:42 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 08:53:42 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 08:53:42 INFO - Using env: {'DISPLAY': ':0', 08:53:42 INFO - 'HOME': '/home/cltbld', 08:53:42 INFO - 'LANG': 'en_US.UTF-8', 08:53:42 INFO - 'LANGUAGE': 'en_US:en', 08:53:42 INFO - 'LOGNAME': 'cltbld', 08:53:42 INFO - 'MAIL': '/var/mail/cltbld', 08:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:42 INFO - 'MOZ_NO_REMOTE': '1', 08:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:42 INFO - 'NO_EM_RESTART': '1', 08:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:42 INFO - 'PWD': '/builds/slave/test', 08:53:42 INFO - 'SHELL': '/bin/bash', 08:53:42 INFO - 'SHLVL': '1', 08:53:42 INFO - 'TERM': 'linux', 08:53:42 INFO - 'TMOUT': '86400', 08:53:42 INFO - 'USER': 'cltbld', 08:53:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:42 INFO - '_': '/tools/buildbot/bin/python'} 08:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 INFO - Cleaning up... 08:53:42 INFO - Return code: 0 08:53:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:42 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')]} 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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')]} 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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 0x7f335f145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', '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 08:53:42 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 08:53:42 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 08:53:42 INFO - Using env: {'DISPLAY': ':0', 08:53:42 INFO - 'HOME': '/home/cltbld', 08:53:42 INFO - 'LANG': 'en_US.UTF-8', 08:53:42 INFO - 'LANGUAGE': 'en_US:en', 08:53:42 INFO - 'LOGNAME': 'cltbld', 08:53:42 INFO - 'MAIL': '/var/mail/cltbld', 08:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:42 INFO - 'MOZ_NO_REMOTE': '1', 08:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:42 INFO - 'NO_EM_RESTART': '1', 08:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:42 INFO - 'PWD': '/builds/slave/test', 08:53:42 INFO - 'SHELL': '/bin/bash', 08:53:42 INFO - 'SHLVL': '1', 08:53:42 INFO - 'TERM': 'linux', 08:53:42 INFO - 'TMOUT': '86400', 08:53:42 INFO - 'USER': 'cltbld', 08:53:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:42 INFO - '_': '/tools/buildbot/bin/python'} 08:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:43 INFO - Cleaning up... 08:53:43 INFO - Return code: 0 08:53:43 INFO - Running post-action listener: _resource_record_post_action 08:53:43 INFO - Running post-action listener: _start_resource_monitoring 08:53:43 INFO - Starting resource monitoring. 08:53:43 INFO - [mozharness: 2016-12-30 16:53:43.207494Z] Finished create-virtualenv step (success) 08:53:43 INFO - [mozharness: 2016-12-30 16:53:43.207991Z] Running install step. 08:53:43 INFO - Running pre-action listener: _resource_record_pre_action 08:53:43 INFO - Running main action method: install 08:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:43 INFO - Reading from file tmpfile_stdout 08:53:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:43 INFO - Reading from file tmpfile_stdout 08:53:43 INFO - Output received: 08:53:43 INFO - Usage: mozinstall [options] installer 08:53:43 INFO - Options: 08:53:43 INFO - -h, --help show this help message and exit 08:53:43 INFO - -d DEST, --destination=DEST 08:53:43 INFO - Directory to install application into. [default: 08:53:43 INFO - "/builds/slave/test"] 08:53:43 INFO - --app=APP Application being installed. [default: firefox] 08:53:43 INFO - mkdir: /builds/slave/test/build/application 08:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:53:59 INFO - Reading from file tmpfile_stdout 08:53:59 INFO - Output received: 08:53:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:59 INFO - Running post-action listener: _resource_record_post_action 08:53:59 INFO - [mozharness: 2016-12-30 16:53:59.477562Z] Finished install step (success) 08:53:59 INFO - [mozharness: 2016-12-30 16:53:59.477802Z] Running run-tests step. 08:53:59 INFO - Running pre-action listener: _resource_record_pre_action 08:53:59 INFO - Running main action method: run_tests 08:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:59 INFO - Python 2.7.3 08:53:59 INFO - Return code: 0 08:53:59 INFO - grabbing minidump binary from tooltool 08:53: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')]} 08:53:59 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 0x2998f60>, '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 0x2999d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:59 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 08:53:59 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 08:53:59 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 08:53:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:59 INFO - Return code: 0 08:53:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 08:53:59 INFO - Using env: {'DISPLAY': ':0', 08:53:59 INFO - 'HOME': '/home/cltbld', 08:53:59 INFO - 'LANG': 'en_US.UTF-8', 08:53:59 INFO - 'LANGUAGE': 'en_US:en', 08:53:59 INFO - 'LOGNAME': 'cltbld', 08:53:59 INFO - 'MAIL': '/var/mail/cltbld', 08:53:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:59 INFO - 'MOZ_NO_REMOTE': '1', 08:53:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:59 INFO - 'NO_EM_RESTART': '1', 08:53:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:59 INFO - 'PWD': '/builds/slave/test', 08:53:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:59 INFO - 'SHELL': '/bin/bash', 08:53:59 INFO - 'SHLVL': '1', 08:53:59 INFO - 'TERM': 'linux', 08:53:59 INFO - 'TMOUT': '86400', 08:53:59 INFO - 'USER': 'cltbld', 08:53:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060', 08:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:59 INFO - '_': '/tools/buildbot/bin/python'} 08:53:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:53:59 INFO - mozversion application_buildid: 20161230070824 08:53:59 INFO - mozversion application_changeset: 4fc37724722145c3664a6db039748e9dc3c55451 08:53:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:53:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:59 INFO - mozversion application_name: Firefox 08:53:59 INFO - mozversion application_remotingname: firefox-dev 08:53:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:59 INFO - mozversion application_vendor: Mozilla 08:53:59 INFO - mozversion application_version: 52.0a2 08:53:59 INFO - mozversion platform_buildid: 20161230070824 08:53:59 INFO - mozversion platform_changeset: 4fc37724722145c3664a6db039748e9dc3c55451 08:53:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:59 INFO - mozversion platform_version: 52.0a2 08:53:59 INFO - using testdate: 1483116839 08:53:59 INFO - actual date: 1483116839 08:53:59 INFO - starting webserver on 'localhost:36281' 08:53:59 INFO - SUITE-START | Running 2 tests 08:53:59 INFO - TEST-START | dromaeo_css 08:53:59 INFO - operating with platform_type : linux_ 08:53:59 INFO - Initialising browser for dromaeo_css test... 08:53:59 INFO - TEST-INFO | started process 10602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAk4mW/profile http://localhost:36281/getInfo.html) 08:54:03 INFO - PROCESS | 10602 | __metrics Screen width/height:1600/1200 08:54:03 INFO - PROCESS | 10602 | colorDepth:24 08:54:03 INFO - PROCESS | 10602 | Browser inner width/height: 1024/697 08:54:03 INFO - PROCESS | 10602 | __metrics 08:54:04 INFO - PROCESS | 10602 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:04 INFO - PROCESS | 10602 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:05 INFO - PROCESS | 10602 | console.error: PushService: 08:54:05 INFO - PROCESS | 10602 | stateChangeProcessEnqueue: Error transitioning state 08:54:05 INFO - PROCESS | 10602 | UnknownError 08:54:05 INFO - TEST-INFO | 10602: exit 0 08:54:05 INFO - Browser initialized. 08:54:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:05 INFO - TEST-INFO | started process 10698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAk4mW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:17 INFO - PROCESS | 10698 | RSS: Main: 148594688 08:54:17 INFO - PROCESS | 10698 | 08:55:09 INFO - PROCESS | 10698 | 1483116909032 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] 08:57:19 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36281/tests/dromaeo/cssquery-ext.html) 08:57:20 INFO - PROCESS | 10698 | RSS: Main: 241696768 08:57:20 INFO - PROCESS | 10698 | 09:00:22 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-ext.html (next: http://localhost:36281/tests/dromaeo/cssquery-jquery.html) 09:00:23 INFO - PROCESS | 10698 | RSS: Main: 232148992 09:00:23 INFO - PROCESS | 10698 | 09:03:25 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36281/tests/dromaeo/cssquery-mootools.html) 09:03:25 INFO - PROCESS | 10698 | RSS: Main: 177520640 09:03:25 INFO - PROCESS | 10698 | 09:06:27 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36281/tests/dromaeo/cssquery-prototype.html) 09:06:28 INFO - PROCESS | 10698 | RSS: Main: 175312896 09:06:28 INFO - PROCESS | 10698 | 09:09:31 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36281/tests/dromaeo/cssquery-yui.html) 09:09:31 INFO - PROCESS | 10698 | RSS: Main: 174940160 09:09:31 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-yui.html (next: http://localhost:36281/tests/dromaeo/cssquery-dojo.html) 09:12:34 INFO - PROCESS | 10698 | RSS: Main: 257994752 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | __start_tp_report 09:12:34 INFO - PROCESS | 10698 | _x_x_mozilla_page_load 09:12:34 INFO - PROCESS | 10698 | _x_x_mozilla_page_load_details 09:12:34 INFO - PROCESS | 10698 | |i|pagename|runs| 09:12:34 INFO - PROCESS | 10698 | |0;dojo.html;3208.4866421372585;3212.7269182119517;3242.870285188594;3261.184703824044;3283.261266215102;5429.131338985763;5497.450254974506;5508.063629183039;5528.723563821813;5544.029794785916;5446.455354464551;5553.583481238903;5555.583331250152;5563.777448902039;5585.916211256835;5002.224655178444;5025.673331233476;5026.97486512567;5087.414947281073;5130.410002849682;4898.559129678329;4910.337104490884;5069.087564238435;5124.5644120249635;5129.102407078765;4967.577755890754;4981.452040275567;4992.77532511036;5020.497950204968;5020.799168033274;5001.974990125044;5039.44566097729;5101.4133374662015;5101.591872650179;5132.923006154911;4785.928211076836;4978.253262010728;4983.302337672729;5009.974950125263;5053.36832895888;5344.225087362311;5385.21914322425;5401.7299135043095;5408.35099788024;5464.016477034133;5854.4730974212525;5861.150133230658;5962.2249107615735;5963.642181469126;5979.22270104888;5791.623544469596;6006.519478441714;6015.578909476339;6025.246844144482;6027.517798576104;5440.836774896759;5467.343918729778;5519.724013799294;5522.751476183581;5536.2249285100115;6056.0613104967915;6068.150458935753;6076.635401875901;6077.696115194222;6080.726367313481;5649.774009039675;5797.072468405035;5811.651300921958;5811.941880581225;5812.59311848175;5777.2200752897825;5792.507636850914;5879.970600147058;5890.911636325459;5981;5910.261217347832;5910.320313163955;5910.379410161871;5929.495992840571;5950.523958083343;5864.618799778001;5909.734061967136;5923.318818335946;5935.080062590219;5941.168236446901;4448.043670610834;4491.932621010687;4521.276595744665;4526;4592.173408786383;4064.207479541461;4077.8776636700945;4102.753834769924;4108.712390132662;4108.794560271975;5630;5631.2960879890015;5638.436156384329;5639.971800140973;5651.491365777018;5683.346415162227;5741.712914354265;5775.104858746901;5871.119332100219;5872.64764114146;5562.471565201299;5610.915836262459;5624.29696287964;5630.662160270397;5651.095824668116;5049.293098966147;5065.164247899129;5068.619853510928;5072.391313042384;5099.69401835891;5954.791582294599;6005.579609427298;6116.755329786759;6175.722092505848;6177.96911015442;5770.278715160605;5774.1916131740745;5801.796937107181;5842.1820945066875;5875.559333049953;6125.509959203342;6158.107074474266;6159.414855588712;6161.938380616137;6178.598391104564;5612.102063669957;5832.270966129234;5874.471297583238;5905.498032667271;5906.0255057914965;5760.308762948473;5831.504322132666;5916.7041647918295;5925.4370834770625;6010.4891084258325;5758.971205143947;5795.710214489343;5797.8550536236935;5805;5806.216160818235;5737.426257374229;5796.62321949072;5799.623024503394;5809.099589563624;5812.099124635688;5545.057340252086;5598.440155984369;5633.8591535211945;5649.406812284651;5671.943280567307;5780.653160810365;5785.0454674978155;5789.768409263583;5795.130730390475;5807.651540907559;5481.972590137183;5531.3362396512675;5639.492445679908;5655.066913959151;5657.038303488334 09:12:34 INFO - PROCESS | 10698 | |1;ext.html;588.2705445247894;620.8323752586801;650.8047585724283;661.7022339947025;683.6889215406991;35330.82334588327;35855;38104.61895381049;45690.77154614222;46724.532754672444;47883.76058119713;48284.2757358639;48318.51681483184;48375.51624483754;48396.2740558891;8915.598798054087;9060.275177985779;9067.909320906772;9068.455892646462;9073.500957447337;8464.280536154434;8661.350398720122;8675.305975521944;8858.60136293865;8986.326025548078;10937.781244375108;11161.944190279037;11241.662750117468;11261.943690281578;11264.43677816106;10849.349039057643;10906.236563440561;10929.289596176222;10933;10935.234533582652;10801.621943231949;10869.184811139196;10882.891171088346;10892.40091794951;10892.40091794951;44663;44696.776516117214;44939.55060449387;44946;45185.77407112976;3542.6811586957297;3727.4408838674144;3766.0584853786554;3831.578526362098;3962.049108214008;33834.661653383395;33863.32273354519;34253.31493370143;34605.65394346049;35455.645443545494;4245.660347172219;4333.479982402132;4334.219840428722;4368.49762277339;4416.24923762961;349864;349868;350380;352057;352612;38823;63999.68000159969;64493;64548.677256614355;64563;39798.60201398007;41829.79085104555;41835.163296733896;41839.37240941388;41879.58120418818;15956.840431595536;16046.358145674043;16054.75917861233;16065.518034458984;16074.115923624078;13294.268815215062;13296.268705221113;13310.467581296833;13392.464301428028;13433.529826456223;8958.641654333884;9186.311026673025;9286.257099432029;9589.664361747306;9608;3517.8592856285973;3590.676839084495;3629.7459177857295;3631.4915911772373;3635.563732352082;1001.649422702063;1055.5250137438184;1094.2941802537478;1099.741560733227;1102.393683474086;34524.13689657779;35427;35926.02354158062;39088.413673794916;39157;1078.0297732041226;1097.3909480238544;1111.9888801112047;1143.4054291768234;1150.8273758936227;18319.725204121947;18429.81570184308;19381;19436;19442.222311107398;519847;519888;520457;521186;521405;63287;63565;63704.68147659232;63705.36294637087;63729.36270637327;1351.4121357209644;1398.7901814727873;1429.978550321746;1466.618679143409;1480.7704805754909;31767.841160794047;35530;36364.636353636124;36588;36610.45084323791;55045;55856.44143558675;55865;55873.72063139658;55892;407092;411124;411550;412598;413253;28220.576691349237;28501.42997140087;28950.710492895643;29123.980660676774;33073.33853322968;51040;51484.74257628688;51579.74210128925;51629.741851290506;51687.48312516977;43139.784301078296;43178.13643727045;43429.34855977226;44235;44437.77781111074;43333.78333108314;43474.91312717081;43872;44365.556344437435;44943.32585011162;43594;44486;45032.324515131644;45285.77357113193;46922.765386172854;37653.81173094117;39694.80152599334;40307.180366038425;40583.7970810144;40733.79633101934;29814.10557683273;29954.25114372158;30325.696743032287;30483.2379190522;30704 09:12:34 INFO - PROCESS | 10698 | |2;jquery.html;375.4780854612088;396.6588733689025;413.7931034482759;415.38730372700263;415.58856731835493;15281.388744450223;19925.701114483294;20149.194032238713;20307.086181121867;20345.593088138266;19810.70283945742;19892.900535497338;19998.10008549615;20133.899330503362;20613.793862061375;4822.68652537584;5609.298837645284;5725.198472213893;5732.885342293152;5745.482906538411;5682.17608446775;5756.712164391784;5758.712064396785;5762.711864406784;5767.452092051249;5500.1749737539485;5659.320881494226;5683.573731970098;5688.175214593882;5725.685087320196;5545.085060964936;5597.468240517144;5611.466910643482;5613.550915926716;5614.831555053355;5076.187809950427;5316.9734151329385;5348.973255133738;5363.088274993261;5376.8118115865755;13374.39815208318;13477.730445391036;13503.324833758274;18629;23541.646875296883;2218.944526386837;2271.772822717715;2320.93037208884;2325.2210509479346;2395.8083353331867;10320.741981450525;10423.218258630557;10846.132309415307;10924.344539327587;15395.923020384938;1888.6411581799553;1903.3623736048442;1927.7204805303152;1945.601151763885;1989.383291179739;85029;85955;90277;91306.5434672829;91307.63038554427;8975.192232699088;9463.148316651397;9528.380655257524;11008.889911100787;11090.55637774496;12265.754684906253;12307.4461649226;12308.938455307667;12309.93845030787;12321.93839030799;7976.960115199387;8025.518468891768;8046.798830029179;8169.550674712829;8202.835943281101;8033.1163572007035;8050.315723163597;8302.750917472486;8529.104444033412;8780.78048048804;3769.2838360711376;3797.430385442206;3823.7323387362617;3886.553046399644;3983.183447393277;1916.6837471817273;1961.8038196180269;1976.6244413561378;1979.3072424651546;1979.9307024254083;995.2187532786728;1009.0061289629709;1055.6674647486018;1068.4497483795851;1094.7372630568607;19957.20171193136;21131.683024754642;21190;21243.150273989177;21298.57402851965;1025.825609646362;1040.9843852342221;1043.1706793099504;1057.4501259345097;1067.7010437077631;10963.177761667906;11578.962987876852;12014.798520147915;12029.09781766371;12034.81947770784;445190;466268;505526;509936;515744;59313.703431482565;59753;102913.48543257236;103387.48306258571;103401;1011.903869132446;1049.3441599000626;1072.8658917635296;1088.8747794003632;1091.476091476096;17421.912890435466;18032.819671803114;18208.544786380447;18739.531511712317;19199.52001199981;45547.316790248835;45735.54264457313;46735.76632116818;47199;48212.276815847086;61516.38483615286;62202;62968.37031629808;63532;63612.68193659002;5632.971835140798;7308.8903666443985;7328.303811137934;8733.606987685442;9054.139856713602;9897.901020989699;13529.661758456117;14309.35607897668;14388.928055359656;14631.487897923522;12009.459574319002;12307.507699691912;12509.311987840756;12641.93679031599;13133.540326088923;12311.815322769986;12636.936815315865;12644.557440489538;12879;12925.159864609146;12392.56626018085;12456.31490268044;12639.747205056032;12723.872761272269;12866.456025277026;8752.037275899773;8783.692570760248;8842.425242359226;8863.246624037029;8945.37382383227;10088.89911100909;12169.574064907685;12195.634130976085;12296.938515307365;12449.25304481734 09:12:34 INFO - PROCESS | 10698 | |3;mootools.html;1413.936372863221;1516.9014014089084;1541.5837723814566;1650.7771450854132;1816.6820806358876;7415.777526674195;8602.61288242029;8910.643574257021;8911.910880891197;9103.863442048374;8916.643334266622;8955.596998135083;9004.234640055603;9014.819703605925;9018.909810901889;2512.5854234051358;2539.7587229213195;2543.7201907790127;2545.5036267927762;2547.9363015924564;2504.7119581248116;2554.8083893707953;2574.7167811540717;2575.2789219018705;2577.5489289374377;2441.0967941861536;2442.0598069743187;2454.3250606083293;2457.459358941039;2510.1967370441466;2380.6786083878715;2439.2804122783823;2458.016793282692;2461.716902556211;2464.876756162185;2461.655368248447;2465.839720418167;2502.2993561802723;2503.2740505253455;2511.045802595002;8466.365022623328;8830.86753698695;8868.733937981806;8919.554022298858;8950.32872534556;5163.173892177234;5295.7881684732565;5305.124654432014;5305.7877684892555;5311.681299122027;3401.302732939766;3437.364087643794;3495.667911548399;3505.2288496530723;3579.821008949542;1093.5133865429887;1119.8544189255344;1133.3256712256277;1144.633717210493;1154.4804837823012;12497.312647804367;12642.304673242968;12673.746525069539;12698.873011269861;12714.61856144317;4623.53764623535;4695.715499453817;4724.645651576146;4788.880277993078;4869.464358920516;9173.678921237859;9180.44917304964;9193.77015574616;9194.310426718022;9201.401908875901;5089.949100508948;5100.132977393852;5120.795168193231;5123.948760512347;5133.307003554547;4170.979145104255;4216.987922898544;4220.725652832556;4320.524742278347;4801.735904525215;4126.525449573277;4133.683380416645;4212.53662097169;4269.210196113729;4277.721948073366;1274.350081458463;1306.817045613615;1307.6338625184962;1312.7177656803833;1321.7422602592594;799.5682331540903;882.5057967538071;904.5341649050744;907.9727608171765;920.2729843423754;6102.237220347457;6152.323244443108;6244;6414.262359828586;6415.358464153547;479.6234955559869;484.0391822232865;488.94132704075736;490.22054932656533;499.79008816297244;3991.401289806552;4030.6573941214738;4053.7973101344814;4067.91864162721;4069.959300406958;10723.731906702238;11234.719132021764;11247.887521124847;11254;11273;11096.500657470433;11109.666709998713;11119.999200072032;11129.72175695598;11131.944340278247;8354.66581336752;8490.19343162411;8497.61760720769;8577.185167409087;8579.65681372738;5973.49225315853;5988.4909782668965;6029.758809647565;6079.878402431838;6118.235220597426;10121.240906932157;10209.081182693593;10242.6415075472;10334.638287659896;10358.741031473972;8604.870926935975;8850;9840.950795245977;10208.846867297145;10395.792084158425;7529.284717951786;7673.155952845071;7710.537367757953;7889.802754931173;7909.406794490551;8414.200650938152;8436.620352084294;8481.27909127731;8508.191721786421;8516.957415213132;7314.6708398121145;7515.549067055776;7527.096748390229;7609.277118673717;7685.5004424712215;7332.706691732485;7392.075990501187;7404.370628496638;7502.962485187539;7527.585982771;6724.697388617622;6883.65581720922;6890.621015844176;6895.827604309932;6899.137607799025;5138.794448222029;5230.843074707765;5276.788928442973;5366.6243362964215;5414.891702165856;5196.194589838581;5289.444608316071;5330.360356757214;5363.168708850135;5379.435159308373 09:12:34 INFO - PROCESS | 10698 | |4;prototype.html;345.20602613987825;345.59737905340273;346.83871999520215;355.6603443711256;355.9555055618048;5288.603354748399;5323.547498462625;5329.493698098684;5330.600204984627;5331.520163185312;5232.09028704523;5235.55497782689;5241.580673546107;5260.263563101169;5265.76304066317;3935.586763389853;3988.464441190148;3988.660963818079;4073.61497090989;4161.417401563784;4134.772587507686;4149.315362965107;4153.190127925056;4170.332746760519;4174.436451079111;4124.587541245882;4128.1330920506725;4130.380442933569;4137.731047481919;4151.854685086023;3858.459815625815;3871.303165430207;4092.3247664135383;4137.81379837908;4142.855000074983;3679.889603311878;3680.5399325084363;3680.7975561344115;3686.1153323202507;3687.9262414751825;5147.922781158286;5168;5185.248139019859;5193.68837869729;5223.448055322379;4436.201483732927;4654.695925516857;4682.555157260055;4770.236762118045;4783.162946484351;5499.230107784913;5507.008738427082;5521.3926468088475;5532.6680399175775;5533.78256783507;3962.385830196324;3971.8283106483655;3972.8609498667697;3975.886751709526;3984.4820173377275;5427.701476418795;5603.7478313475995;5645.108888522309;5706.3152421709665;5779.884402311972;4000.4999375078114;4016.357382818735;4028.441939368522;4031.314676505001;4031.637152656275;4048.2510735513433;4088.6729061674996;4095.1809638072505;4096.8249606555155;4104.651104656078;4563.224251877189;4642.373279607277;4656.976715116402;4663.183942809995;4669.34629151919;5475.123980163155;5516.668999860021;5537.944620553743;5542.196381524656;5550.694711790809;1358.8721361270123;1363.754524185656;1368.3295185359302;1369.5069774881035;1370.8903287737157;889.8264838356588;894;946.5835032585641;966.2897770138942;970.8106919150698;5026.271190677405;5277.920831187535;5405.837824865261;5427;5427.6472029317965;5633.915491267634;5634.32388113429;5650.491455768918;5656.349519805192;5662.886742265214;5270.341207349082;5398.91901621476;5412.891742165213;5425.159100339453;5426.751847075195;2851.800373973802;2862.742353188223;2864.310057066341;2877.906395569712;2887.581300711427;5689.402612725687;5699.401562835843;5714.942850571524;5734.77060917567;5736.340320863071;5301.5493683037375;5542.5565954723525;5604.187392828017;5617.9719101404235;5638.238837756932;5665.5467562594895;5672.631278966854;5700.800471983461;5729.991754329094;5738.942610573841;5191.8182863599595;5457.372402173801;5457.69982650958;5468;5479.424660410759;5498.285222921155;5498.972505137449;5504;5523.861903452285;5524.75138618755;5618.747156378055;5715.599908006399;5745.885082298247;5802;5803.9419605803405;3792.450094736303;3970.186111847122;3974.880753577397;4035.293823580803;4038.425992996161;5630.014747419267;5657.575681823797;5660.575456840836;5667.914981275367;5679.545636349165;5551.167324901297;5566.666000040011;5569.220309156803;5580.470849106474;5584.162375643686;5418.83743487696;5435.864103397288;5483.479069488392;5488.753006114654;5508.228847961369;5444.482774136451;5459.39946605881;5476.3702174250475;5483.588730845123;5496.532794712494;5333.759980800795;5431.619786614899;5488.890222195613;5587.217789509553;5595.608307418442;5455.3453585568395;5460.180972854104;5467.7266136692215;5475.342958844964;5476.17857321405 09:12:34 INFO - PROCESS | 10698 | |5;yui.html;700.912385951756;713.8251128473521;773.5088218980945;848.2026894718964;857.2113655436997;13752.724945501084;13927.442902283921;14258.287085645728;14644.926775366122;14653.633659158526;13263.602091937257;13292.867071329283;13376.866231337684;13418.865811341884;13433.529826456075;726.8291951391419;741.0181509499907;851.1318455175701;866.1425189062813;868.4702331577732;848.2535368875381;863.3222920007795;869.4956924983494;870.3646338173137;879.7668617816252;916.4821875640275;919.2416256588308;919.6321471411422;920.4661296448044;920.5719340506663;753.4951582439778;770.8843673448971;912.3020889019872;912.5984566790625;913.0413066280412;640.4300172846171;654.7446495866616;658.1181217169017;662.3310456438983;662.4369286106819;11923.463444145034;11954;11972.102092343022;11979.10156738248;11993.16047876649;13057.738845223137;13189.736205275936;13496.865031349658;13566.321683915765;14191.645208869757;12700.872991270062;12716.364181790874;12813.231206127663;13057.738845223137;13122.737545249138;3909.9413508797393;3913.5695073541888;3917.843286268546;4058.594140585947;4062.5531191568903;63024.68487657578;64742.02886956747;65329;65338.3466165337;65908.3409165907;9873.308868379288;10088.638033865482;10118.949405252926;10247.692569222936;10332.586696532206;20336.288229911883;20455.488612784502;20496.59006819885;20697.793022069887;20914;7565.546067235983;7688.923110768933;7713.961430192813;7901.841963160705;8075.313598344089;4589.885252868638;4723.923018288861;4792.7124372537755;4851.369321988119;4864.416270047617;3455.274392377629;3569.37535931211;3574.1064733816547;3575.803330816778;3582.9283414331567;612.745710530125;627.5575719118102;632.7469012394987;633.3223450907577;634.7714822663837;679.9456043516606;715.3418854653731;783.9647215875299;805.6253841963515;811.9147489513634;8803.471791692518;8824.691135810215;8975.640974361084;9494.192993595621;9553.379030363005;673.6829498330752;726.2519604807057;734.1117248129716;750.0886422996086;766.7431410477441;4273.615374616237;4333.956660433419;4346.782660866944;4439.822407103679;4491;55918.720406397704;84898;88124.11875881287;92647;94830.5258473717;49087.26369104466;62191.37808621856;69076.65461672659;84175;84183;73047.2695273051;74563.62718186375;75655;76379.61810190913;77637.61181194171;8478.448900821428;8669.826603468022;8726.738197854074;8740.650373984969;8756.080611535697;49779.25331119964;50125.749371254366;50700.74649626728;51937.74031129971;52083.218751718;57181;57249.42750572441;58293;63921.68039159774;67122.66438667971;13200.471981120647;13317.267550284827;13694.863051369359;13698.109622874481;13772.449102035805;14342.784858226927;15058.924705376403;15090.849091509384;15135.318910648826;16001.279942402387;11715.88284117182;13464.25946572948;13611.387487563281;13756.931215343859;14069.507567235507;12866.614001579968;13291.601251962456;13919.860801391857;13935.58193254204;14415.78376324377;12814;13043.804342935053;13509;13668.248246346546;14072.085314454527;10116.03897629724;10187.286889917634;10214.131798797185;10754.797356871799;10803.243772935819;10230.539625716712;10990.725231869268;11164.776704465703;11194.552217911192;11295.887041129483 09:12:34 INFO - PROCESS | 10698 | __end_tp_report 09:12:34 INFO - PROCESS | 10698 | __start_cc_report 09:12:34 INFO - PROCESS | 10698 | _x_x_mozilla_cycle_collect,1071 09:12:34 INFO - PROCESS | 10698 | __end_cc_report 09:12:34 INFO - PROCESS | 10698 | __startTimestamp1483117954640__endTimestamp 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | ------- Summary: start ------- 09:12:34 INFO - PROCESS | 10698 | Number of tests: 6 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#0] dojo.html Cycles:165 Average:5479.57 Median:5651.10 stddev:612.19 (10.8%) stddev-sans-first:587.57 09:12:34 INFO - PROCESS | 10698 | Values: 3208.5 3212.7 3242.9 3261.2 3283.3 5429.1 5497.5 5508.1 5528.7 5544.0 5446.5 5553.6 5555.6 5563.8 5585.9 5002.2 5025.7 5027.0 5087.4 5130.4 4898.6 4910.3 5069.1 5124.6 5129.1 4967.6 4981.5 4992.8 5020.5 5020.8 5002.0 5039.4 5101.4 5101.6 5132.9 4785.9 4978.3 4983.3 5010.0 5053.4 5344.2 5385.2 5401.7 5408.4 5464.0 5854.5 5861.2 5962.2 5963.6 5979.2 5791.6 6006.5 6015.6 6025.2 6027.5 5440.8 5467.3 5519.7 5522.8 5536.2 6056.1 6068.2 6076.6 6077.7 6080.7 5649.8 5797.1 5811.7 5811.9 5812.6 5777.2 5792.5 5880.0 5890.9 5981.0 5910.3 5910.3 5910.4 5929.5 5950.5 5864.6 5909.7 5923.3 5935.1 5941.2 4448.0 4491.9 4521.3 4526.0 4592.2 4064.2 4077.9 4102.8 4108.7 4108.8 5630.0 5631.3 5638.4 5640.0 5651.5 5683.3 5741.7 5775.1 5871.1 5872.6 5562.5 5610.9 5624.3 5630.7 5651.1 5049.3 5065.2 5068.6 5072.4 5099.7 5954.8 6005.6 6116.8 6175.7 6178.0 5770.3 5774.2 5801.8 5842.2 5875.6 6125.5 6158.1 6159.4 6161.9 6178.6 5612.1 5832.3 5874.5 5905.5 5906.0 5760.3 5831.5 5916.7 5925.4 6010.5 5759.0 5795.7 5797.9 5805.0 5806.2 5737.4 5796.6 5799.6 5809.1 5812.1 5545.1 5598.4 5633.9 5649.4 5671.9 5780.7 5785.0 5789.8 5795.1 5807.7 5482.0 5531.3 5639.5 5655.1 5657.0 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#1] ext.html Cycles:180 Average:59749.65 Median:39746.70 stddev:114615.65 (288.4%) stddev-sans-first:114851.10 09:12:34 INFO - PROCESS | 10698 | Values: 588.3 620.8 650.8 661.7 683.7 35330.8 35855.0 38104.6 45690.8 46724.5 47883.8 48284.3 48318.5 48375.5 48396.3 8915.6 9060.3 9067.9 9068.5 9073.5 8464.3 8661.4 8675.3 8858.6 8986.3 10937.8 11161.9 11241.7 11261.9 11264.4 10849.3 10906.2 10929.3 10933.0 10935.2 10801.6 10869.2 10882.9 10892.4 10892.4 44663.0 44696.8 44939.6 44946.0 45185.8 3542.7 3727.4 3766.1 3831.6 3962.0 33834.7 33863.3 34253.3 34605.7 35455.6 4245.7 4333.5 4334.2 4368.5 4416.2 349864.0 349868.0 350380.0 352057.0 352612.0 38823.0 63999.7 64493.0 64548.7 64563.0 39798.6 41829.8 41835.2 41839.4 41879.6 15956.8 16046.4 16054.8 16065.5 16074.1 13294.3 13296.3 13310.5 13392.5 13433.5 8958.6 9186.3 9286.3 9589.7 9608.0 3517.9 3590.7 3629.7 3631.5 3635.6 1001.6 1055.5 1094.3 1099.7 1102.4 34524.1 35427.0 35926.0 39088.4 39157.0 1078.0 1097.4 1112.0 1143.4 1150.8 18319.7 18429.8 19381.0 19436.0 19442.2 519847.0 519888.0 520457.0 521186.0 521405.0 63287.0 63565.0 63704.7 63705.4 63729.4 1351.4 1398.8 1430.0 1466.6 1480.8 31767.8 35530.0 36364.6 36588.0 36610.5 55045.0 55856.4 55865.0 55873.7 55892.0 407092.0 411124.0 411550.0 412598.0 413253.0 28220.6 28501.4 28950.7 29124.0 33073.3 51040.0 51484.7 51579.7 51629.7 51687.5 43139.8 43178.1 43429.3 44235.0 44437.8 43333.8 43474.9 43872.0 44365.6 44943.3 43594.0 44486.0 45032.3 45285.8 46922.8 37653.8 39694.8 40307.2 40583.8 40733.8 29814.1 29954.3 30325.7 30483.2 30704.0 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#2] jquery.html Cycles:180 Average:29181.24 Median:21270.86 stddev:80887.02 (380.3%) stddev-sans-first:81085.01 09:12:34 INFO - PROCESS | 10698 | Values: 375.5 396.7 413.8 415.4 415.6 15281.4 19925.7 20149.2 20307.1 20345.6 19810.7 19892.9 19998.1 20133.9 20613.8 4822.7 5609.3 5725.2 5732.9 5745.5 5682.2 5756.7 5758.7 5762.7 5767.5 5500.2 5659.3 5683.6 5688.2 5725.7 5545.1 5597.5 5611.5 5613.6 5614.8 5076.2 5317.0 5349.0 5363.1 5376.8 13374.4 13477.7 13503.3 18629.0 23541.6 2218.9 2271.8 2320.9 2325.2 2395.8 10320.7 10423.2 10846.1 10924.3 15395.9 1888.6 1903.4 1927.7 1945.6 1989.4 85029.0 85955.0 90277.0 91306.5 91307.6 8975.2 9463.1 9528.4 11008.9 11090.6 12265.8 12307.4 12308.9 12309.9 12321.9 7977.0 8025.5 8046.8 8169.6 8202.8 8033.1 8050.3 8302.8 8529.1 8780.8 3769.3 3797.4 3823.7 3886.6 3983.2 1916.7 1961.8 1976.6 1979.3 1979.9 995.2 1009.0 1055.7 1068.4 1094.7 19957.2 21131.7 21190.0 21243.2 21298.6 1025.8 1041.0 1043.2 1057.5 1067.7 10963.2 11579.0 12014.8 12029.1 12034.8 445190.0 466268.0 505526.0 509936.0 515744.0 59313.7 59753.0 102913.5 103387.5 103401.0 1011.9 1049.3 1072.9 1088.9 1091.5 17421.9 18032.8 18208.5 18739.5 19199.5 45547.3 45735.5 46735.8 47199.0 48212.3 61516.4 62202.0 62968.4 63532.0 63612.7 5633.0 7308.9 7328.3 8733.6 9054.1 9897.9 13529.7 14309.4 14388.9 14631.5 12009.5 12307.5 12509.3 12641.9 13133.5 12311.8 12636.9 12644.6 12879.0 12925.2 12392.6 12456.3 12639.7 12723.9 12866.5 8752.0 8783.7 8842.4 8863.2 8945.4 10088.9 12169.6 12195.6 12296.9 12449.3 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#3] mootools.html Cycles:180 Average:5800.89 Median:495.01 stddev:3278.87 (662.4%) stddev-sans-first:3271.49 09:12:34 INFO - PROCESS | 10698 | Values: 1413.9 1516.9 1541.6 1650.8 1816.7 7415.8 8602.6 8910.6 8911.9 9103.9 8916.6 8955.6 9004.2 9014.8 9018.9 2512.6 2539.8 2543.7 2545.5 2547.9 2504.7 2554.8 2574.7 2575.3 2577.5 2441.1 2442.1 2454.3 2457.5 2510.2 2380.7 2439.3 2458.0 2461.7 2464.9 2461.7 2465.8 2502.3 2503.3 2511.0 8466.4 8830.9 8868.7 8919.6 8950.3 5163.2 5295.8 5305.1 5305.8 5311.7 3401.3 3437.4 3495.7 3505.2 3579.8 1093.5 1119.9 1133.3 1144.6 1154.5 12497.3 12642.3 12673.7 12698.9 12714.6 4623.5 4695.7 4724.6 4788.9 4869.5 9173.7 9180.4 9193.8 9194.3 9201.4 5089.9 5100.1 5120.8 5123.9 5133.3 4171.0 4217.0 4220.7 4320.5 4801.7 4126.5 4133.7 4212.5 4269.2 4277.7 1274.4 1306.8 1307.6 1312.7 1321.7 799.6 882.5 904.5 908.0 920.3 6102.2 6152.3 6244.0 6414.3 6415.4 479.6 484.0 488.9 490.2 499.8 3991.4 4030.7 4053.8 4067.9 4070.0 10723.7 11234.7 11247.9 11254.0 11273.0 11096.5 11109.7 11120.0 11129.7 11131.9 8354.7 8490.2 8497.6 8577.2 8579.7 5973.5 5988.5 6029.8 6079.9 6118.2 10121.2 10209.1 10242.6 10334.6 10358.7 8604.9 8850.0 9841.0 10208.8 10395.8 7529.3 7673.2 7710.5 7889.8 7909.4 8414.2 8436.6 8481.3 8508.2 8517.0 7314.7 7515.5 7527.1 7609.3 7685.5 7332.7 7392.1 7404.4 7503.0 7527.6 6724.7 6883.7 6890.6 6895.8 6899.1 5138.8 5230.8 5276.8 5366.6 5414.9 5196.2 5289.4 5330.4 5363.2 5379.4 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#4] prototype.html Cycles:180 Average:4622.34 Median:5366.34 stddev:1356.80 (25.3%) stddev-sans-first:1322.08 09:12:34 INFO - PROCESS | 10698 | Values: 345.2 345.6 346.8 355.7 356.0 5288.6 5323.5 5329.5 5330.6 5331.5 5232.1 5235.6 5241.6 5260.3 5265.8 3935.6 3988.5 3988.7 4073.6 4161.4 4134.8 4149.3 4153.2 4170.3 4174.4 4124.6 4128.1 4130.4 4137.7 4151.9 3858.5 3871.3 4092.3 4137.8 4142.9 3679.9 3680.5 3680.8 3686.1 3687.9 5147.9 5168.0 5185.2 5193.7 5223.4 4436.2 4654.7 4682.6 4770.2 4783.2 5499.2 5507.0 5521.4 5532.7 5533.8 3962.4 3971.8 3972.9 3975.9 3984.5 5427.7 5603.7 5645.1 5706.3 5779.9 4000.5 4016.4 4028.4 4031.3 4031.6 4048.3 4088.7 4095.2 4096.8 4104.7 4563.2 4642.4 4657.0 4663.2 4669.3 5475.1 5516.7 5537.9 5542.2 5550.7 1358.9 1363.8 1368.3 1369.5 1370.9 889.8 894.0 946.6 966.3 970.8 5026.3 5277.9 5405.8 5427.0 5427.6 5633.9 5634.3 5650.5 5656.3 5662.9 5270.3 5398.9 5412.9 5425.2 5426.8 2851.8 2862.7 2864.3 2877.9 2887.6 5689.4 5699.4 5714.9 5734.8 5736.3 5301.5 5542.6 5604.2 5618.0 5638.2 5665.5 5672.6 5700.8 5730.0 5738.9 5191.8 5457.4 5457.7 5468.0 5479.4 5498.3 5499.0 5504.0 5523.9 5524.8 5618.7 5715.6 5745.9 5802.0 5803.9 3792.5 3970.2 3974.9 4035.3 4038.4 5630.0 5657.6 5660.6 5667.9 5679.5 5551.2 5566.7 5569.2 5580.5 5584.2 5418.8 5435.9 5483.5 5488.8 5508.2 5444.5 5459.4 5476.4 5483.6 5496.5 5333.8 5431.6 5488.9 5587.2 5595.6 5455.3 5460.2 5467.7 5475.3 5476.2 09:12:34 INFO - PROCESS | 10698 | 09:12:34 INFO - PROCESS | 10698 | [#5] yui.html Cycles:180 Average:17817.72 Median:49952.50 stddev:23540.96 (47.1%) stddev-sans-first:23571.91 09:12:34 INFO - PROCESS | 10698 | Values: 700.9 713.8 773.5 848.2 857.2 13752.7 13927.4 14258.3 14644.9 14653.6 13263.6 13292.9 13376.9 13418.9 13433.5 726.8 741.0 851.1 866.1 868.5 848.3 863.3 869.5 870.4 879.8 916.5 919.2 919.6 920.5 920.6 753.5 770.9 912.3 912.6 913.0 640.4 654.7 658.1 662.3 662.4 11923.5 11954.0 11972.1 11979.1 11993.2 13057.7 13189.7 13496.9 13566.3 14191.6 12700.9 12716.4 12813.2 13057.7 13122.7 3909.9 3913.6 3917.8 4058.6 4062.6 63024.7 64742.0 65329.0 65338.3 65908.3 9873.3 10088.6 10118.9 10247.7 10332.6 20336.3 20455.5 20496.6 20697.8 20914.0 7565.5 7688.9 7714.0 7901.8 8075.3 4589.9 4723.9 4792.7 4851.4 4864.4 3455.3 3569.4 3574.1 3575.8 3582.9 612.7 627.6 632.7 633.3 634.8 679.9 715.3 784.0 805.6 811.9 8803.5 8824.7 8975.6 9494.2 9553.4 673.7 726.3 734.1 750.1 766.7 4273.6 4334.0 4346.8 4439.8 4491.0 55918.7 84898.0 88124.1 92647.0 94830.5 49087.3 62191.4 69076.7 84175.0 84183.0 73047.3 74563.6 75655.0 76379.6 77637.6 8478.4 8669.8 8726.7 8740.7 8756.1 49779.3 50125.7 50700.7 51937.7 52083.2 57181.0 57249.4 58293.0 63921.7 67122.7 13200.5 13317.3 13694.9 13698.1 13772.4 14342.8 15058.9 15090.8 15135.3 16001.3 11715.9 13464.3 13611.4 13756.9 14069.5 12866.6 13291.6 13919.9 13935.6 14415.8 12814.0 13043.8 13509.0 13668.2 14072.1 10116.0 10187.3 10214.1 10754.8 10803.2 10230.5 10990.7 11164.8 11194.6 11295.9 09:12:34 INFO - PROCESS | 10698 | -------- Summary: end -------- 09:12:34 INFO - PROCESS | 10698 | 09:12:35 INFO - TEST-INFO | 10698: exit 0 09:12:35 INFO - TEST-OK | dromaeo_css | took 1115634ms 09:12:35 INFO - TEST-START | kraken 09:12:35 INFO - operating with platform_type : linux_ 09:12:35 INFO - Initialising browser for kraken test... 09:12:35 INFO - TEST-INFO | started process 11016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaCnrG/profile http://localhost:36281/getInfo.html) 09:12:39 INFO - PROCESS | 11016 | __metrics Screen width/height:1600/1200 09:12:39 INFO - PROCESS | 11016 | colorDepth:24 09:12:39 INFO - PROCESS | 11016 | Browser inner width/height: 1024/697 09:12:39 INFO - PROCESS | 11016 | __metrics 09:12:40 INFO - PROCESS | 11016 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:12:40 INFO - PROCESS | 11016 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:40 INFO - PROCESS | 11016 | console.error: PushService: 09:12:40 INFO - PROCESS | 11016 | stateChangeProcessEnqueue: Error transitioning state 09:12:40 INFO - PROCESS | 11016 | UnknownError 09:12:41 INFO - TEST-INFO | 11016: exit 0 09:12:41 INFO - Browser initialized. 09:12:41 INFO - Running cycle 1/1 for kraken test... 09:12:41 INFO - TEST-INFO | started process 11110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaCnrG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:53 INFO - PROCESS | 11110 | RSS: Main: 144617472 09:12:53 INFO - PROCESS | 11110 | 09:12:55 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:56 INFO - PROCESS | 11110 | RSS: Main: 185933824 09:12:56 INFO - PROCESS | 11110 | 09:12:58 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-dft) 09:12:59 INFO - PROCESS | 11110 | RSS: Main: 174690304 09:12:59 INFO - PROCESS | 11110 | 09:13:02 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-fft) 09:13:02 INFO - PROCESS | 11110 | RSS: Main: 267399168 09:13:02 INFO - PROCESS | 11110 | 09:13:05 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-oscillator) 09:13:05 INFO - PROCESS | 11110 | RSS: Main: 173903872 09:13:05 INFO - PROCESS | 11110 | 09:13:07 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:08 INFO - PROCESS | 11110 | RSS: Main: 176013312 09:13:08 INFO - PROCESS | 11110 | 09:13:11 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:11 INFO - PROCESS | 11110 | RSS: Main: 214605824 09:13:11 INFO - PROCESS | 11110 | 09:13:15 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:15 INFO - PROCESS | 11110 | RSS: Main: 213225472 09:13:15 INFO - PROCESS | 11110 | 09:13:18 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36281/tests/kraken/driver.html?testName=json-parse-financial) 09:13:18 INFO - PROCESS | 11110 | RSS: Main: 212070400 09:13:18 INFO - PROCESS | 11110 | 09:13:20 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:21 INFO - PROCESS | 11110 | RSS: Main: 174112768 09:13:21 INFO - PROCESS | 11110 | 09:13:22 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:23 INFO - PROCESS | 11110 | RSS: Main: 181456896 09:13:23 INFO - PROCESS | 11110 | 09:13:25 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:25 INFO - PROCESS | 11110 | RSS: Main: 190439424 09:13:25 INFO - PROCESS | 11110 | 09:13:28 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:29 INFO - PROCESS | 11110 | RSS: Main: 198983680 09:13:29 INFO - PROCESS | 11110 | 09:13:31 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:32 INFO - PROCESS | 11110 | RSS: Main: 195436544 09:13:32 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36281/tests/kraken/driver.html?testName=ai-astar) 09:13:34 INFO - PROCESS | 11110 | RSS: Main: 246943744 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | __start_tp_report 09:13:34 INFO - PROCESS | 11110 | _x_x_mozilla_page_load 09:13:34 INFO - PROCESS | 11110 | _x_x_mozilla_page_load_details 09:13:34 INFO - PROCESS | 11110 | |i|pagename|runs| 09:13:34 INFO - PROCESS | 11110 | |0;ai-astar;103;112;112;112;112;112;112;112;112;111 09:13:34 INFO - PROCESS | 11110 | |1;audio-beat-detection;154;117;120;152;125;118;118;124;150;120 09:13:34 INFO - PROCESS | 11110 | |2;audio-dft;160;160;159;160;161;159;161;158;161;161 09:13:34 INFO - PROCESS | 11110 | |3;audio-fft;75;74;75;118;76;77;74;76;99;76 09:13:34 INFO - PROCESS | 11110 | |4;audio-oscillator;83;82;116;82;83;82;115;82;81;121 09:13:34 INFO - PROCESS | 11110 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;116;117 09:13:34 INFO - PROCESS | 11110 | |6;imaging-darkroom;146;146;146;145;145;146;146;145;146;145 09:13:34 INFO - PROCESS | 11110 | |7;imaging-desaturate;84;85;85;85;84;84;84;84;84;85 09:13:34 INFO - PROCESS | 11110 | |8;json-parse-financial;50;50;50;53;50;52;52;50;51;52 09:13:34 INFO - PROCESS | 11110 | |9;json-stringify-tinderbox;60;61;60;60;61;63;60;61;59;61 09:13:34 INFO - PROCESS | 11110 | |10;stanford-crypto-aes;75;75;75;74;83;75;75;75;74;75 09:13:34 INFO - PROCESS | 11110 | |11;stanford-crypto-ccm;126;122;123;124;120;137;119;128;170;127 09:13:34 INFO - PROCESS | 11110 | |12;stanford-crypto-pbkdf2;152;152;151;153;150;158;161;158;153;157 09:13:34 INFO - PROCESS | 11110 | |13;stanford-crypto-sha256-iterative;64;62;65;62;62;63;62;64;63;60 09:13:34 INFO - PROCESS | 11110 | __end_tp_report 09:13:34 INFO - PROCESS | 11110 | __start_cc_report 09:13:34 INFO - PROCESS | 11110 | _x_x_mozilla_cycle_collect,1596 09:13:34 INFO - PROCESS | 11110 | __end_cc_report 09:13:34 INFO - PROCESS | 11110 | __startTimestamp1483118014349__endTimestamp 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | ------- Summary: start ------- 09:13:34 INFO - PROCESS | 11110 | Number of tests: 14 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.83 (2.5%) stddev-sans-first:0.33 09:13:34 INFO - PROCESS | 11110 | Values: 103.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 112.0 111.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:124.50 stddev:15.55 (12.5%) stddev-sans-first:13.82 09:13:34 INFO - PROCESS | 11110 | Values: 154.0 117.0 120.0 152.0 125.0 118.0 118.0 124.0 150.0 120.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 09:13:34 INFO - PROCESS | 11110 | Values: 160.0 160.0 159.0 160.0 161.0 159.0 161.0 158.0 161.0 161.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:14.70 (19.3%) stddev-sans-first:15.37 09:13:34 INFO - PROCESS | 11110 | Values: 75.0 74.0 75.0 118.0 76.0 77.0 74.0 76.0 99.0 76.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:82.00 stddev:17.08 (20.8%) stddev-sans-first:17.75 09:13:34 INFO - PROCESS | 11110 | Values: 83.0 82.0 116.0 82.0 83.0 82.0 115.0 82.0 81.0 121.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:13:34 INFO - PROCESS | 11110 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:13:34 INFO - PROCESS | 11110 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:13:34 INFO - PROCESS | 11110 | Values: 84.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.15 (2.2%) stddev-sans-first:1.17 09:13:34 INFO - PROCESS | 11110 | Values: 50.0 50.0 50.0 53.0 50.0 52.0 52.0 50.0 51.0 52.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.12 09:13:34 INFO - PROCESS | 11110 | Values: 60.0 61.0 60.0 60.0 61.0 63.0 60.0 61.0 59.0 61.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:2.63 (3.5%) stddev-sans-first:2.78 09:13:34 INFO - PROCESS | 11110 | Values: 75.0 75.0 75.0 74.0 83.0 75.0 75.0 75.0 74.0 75.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:126.50 stddev:15.08 (11.9%) stddev-sans-first:15.94 09:13:34 INFO - PROCESS | 11110 | Values: 126.0 122.0 123.0 124.0 120.0 137.0 119.0 128.0 170.0 127.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:3.69 (2.4%) stddev-sans-first:3.80 09:13:34 INFO - PROCESS | 11110 | Values: 152.0 152.0 151.0 153.0 150.0 158.0 161.0 158.0 153.0 157.0 09:13:34 INFO - PROCESS | 11110 | 09:13:34 INFO - PROCESS | 11110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.42 09:13:34 INFO - PROCESS | 11110 | Values: 64.0 62.0 65.0 62.0 62.0 63.0 62.0 64.0 63.0 60.0 09:13:34 INFO - PROCESS | 11110 | -------- Summary: end -------- 09:13:34 INFO - PROCESS | 11110 | 09:13:35 INFO - TEST-INFO | 11110: exit 0 09:13:35 INFO - TEST-OK | kraken | took 60018ms 09:13:35 INFO - SUITE-END | took 1175s 09:13:35 INFO - Completed test suite (00:19:35) 09:13:35 INFO - javascript benchmark 09:13:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.4866421372585, 3212.7269182119517, 3242.870285188594, 3261.184703824044, 3283.261266215102, 5429.131338985763, 5497.450254974506, 5508.063629183039, 5528.723563821813, 5544.029794785916, 5446.455354464551, 5553.583481238903, 5555.583331250152, 5563.777448902039, 5585.916211256835, 5002.224655178444, 5025.673331233476, 5026.97486512567, 5087.414947281073, 5130.410002849682, 4898.559129678329, 4910.337104490884, 5069.087564238435, 5124.5644120249635, 5129.102407078765, 4967.577755890754, 4981.452040275567, 4992.77532511036, 5020.497950204968, 5020.799168033274, 5001.974990125044, 5039.44566097729, 5101.4133374662015, 5101.591872650179, 5132.923006154911, 4785.928211076836, 4978.253262010728, 4983.302337672729, 5009.974950125263, 5053.36832895888, 5344.225087362311, 5385.21914322425, 5401.7299135043095, 5408.35099788024, 5464.016477034133, 5854.4730974212525, 5861.150133230658, 5962.2249107615735, 5963.642181469126, 5979.22270104888, 5791.623544469596, 6006.519478441714, 6015.578909476339, 6025.246844144482, 6027.517798576104, 5440.836774896759, 5467.343918729778, 5519.724013799294, 5522.751476183581, 5536.2249285100115, 6056.0613104967915, 6068.150458935753, 6076.635401875901, 6077.696115194222, 6080.726367313481, 5649.774009039675, 5797.072468405035, 5811.651300921958, 5811.941880581225, 5812.59311848175, 5777.2200752897825, 5792.507636850914, 5879.970600147058, 5890.911636325459, 5981.0, 5910.261217347832, 5910.320313163955, 5910.379410161871, 5929.495992840571, 5950.523958083343, 5864.618799778001, 5909.734061967136, 5923.318818335946, 5935.080062590219, 5941.168236446901, 4448.043670610834, 4491.932621010687, 4521.276595744665, 4526.0, 4592.173408786383, 4064.207479541461, 4077.8776636700945, 4102.753834769924, 4108.712390132662, 4108.794560271975, 5630.0, 5631.2960879890015, 5638.436156384329, 5639.971800140973, 5651.491365777018, 5683.346415162227, 5741.712914354265, 5775.104858746901, 5871.119332100219, 5872.64764114146, 5562.471565201299, 5610.915836262459, 5624.29696287964, 5630.662160270397, 5651.095824668116, 5049.293098966147, 5065.164247899129, 5068.619853510928, 5072.391313042384, 5099.69401835891, 5954.791582294599, 6005.579609427298, 6116.755329786759, 6175.722092505848, 6177.96911015442, 5770.278715160605, 5774.1916131740745, 5801.796937107181, 5842.1820945066875, 5875.559333049953, 6125.509959203342, 6158.107074474266, 6159.414855588712, 6161.938380616137, 6178.598391104564, 5612.102063669957, 5832.270966129234, 5874.471297583238, 5905.498032667271, 5906.0255057914965, 5760.308762948473, 5831.504322132666, 5916.7041647918295, 5925.4370834770625, 6010.4891084258325, 5758.971205143947, 5795.710214489343, 5797.8550536236935, 5805.0, 5806.216160818235, 5737.426257374229, 5796.62321949072, 5799.623024503394, 5809.099589563624, 5812.099124635688, 5545.057340252086, 5598.440155984369, 5633.8591535211945, 5649.406812284651, 5671.943280567307, 5780.653160810365, 5785.0454674978155, 5789.768409263583, 5795.130730390475, 5807.651540907559, 5481.972590137183, 5531.3362396512675, 5639.492445679908, 5655.066913959151, 5657.038303488334], "value": 5439.317666881136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2705445247894, 620.8323752586801, 650.8047585724283, 661.7022339947025, 683.6889215406991, 35330.82334588327, 35855.0, 38104.61895381049, 45690.77154614222, 46724.532754672444, 47883.76058119713, 48284.2757358639, 48318.51681483184, 48375.51624483754, 48396.2740558891, 8915.598798054087, 9060.275177985779, 9067.909320906772, 9068.455892646462, 9073.500957447337, 8464.280536154434, 8661.350398720122, 8675.305975521944, 8858.60136293865, 8986.326025548078, 10937.781244375108, 11161.944190279037, 11241.662750117468, 11261.943690281578, 11264.43677816106, 10849.349039057643, 10906.236563440561, 10929.289596176222, 10933.0, 10935.234533582652, 10801.621943231949, 10869.184811139196, 10882.891171088346, 10892.40091794951, 10892.40091794951, 44663.0, 44696.776516117214, 44939.55060449387, 44946.0, 45185.77407112976, 3542.6811586957297, 3727.4408838674144, 3766.0584853786554, 3831.578526362098, 3962.049108214008, 33834.661653383395, 33863.32273354519, 34253.31493370143, 34605.65394346049, 35455.645443545494, 4245.660347172219, 4333.479982402132, 4334.219840428722, 4368.49762277339, 4416.24923762961, 349864.0, 349868.0, 350380.0, 352057.0, 352612.0, 38823.0, 63999.68000159969, 64493.0, 64548.677256614355, 64563.0, 39798.60201398007, 41829.79085104555, 41835.163296733896, 41839.37240941388, 41879.58120418818, 15956.840431595536, 16046.358145674043, 16054.75917861233, 16065.518034458984, 16074.115923624078, 13294.268815215062, 13296.268705221113, 13310.467581296833, 13392.464301428028, 13433.529826456223, 8958.641654333884, 9186.311026673025, 9286.257099432029, 9589.664361747306, 9608.0, 3517.8592856285973, 3590.676839084495, 3629.7459177857295, 3631.4915911772373, 3635.563732352082, 1001.649422702063, 1055.5250137438184, 1094.2941802537478, 1099.741560733227, 1102.393683474086, 34524.13689657779, 35427.0, 35926.02354158062, 39088.413673794916, 39157.0, 1078.0297732041226, 1097.3909480238544, 1111.9888801112047, 1143.4054291768234, 1150.8273758936227, 18319.725204121947, 18429.81570184308, 19381.0, 19436.0, 19442.222311107398, 519847.0, 519888.0, 520457.0, 521186.0, 521405.0, 63287.0, 63565.0, 63704.68147659232, 63705.36294637087, 63729.36270637327, 1351.4121357209644, 1398.7901814727873, 1429.978550321746, 1466.618679143409, 1480.7704805754909, 31767.841160794047, 35530.0, 36364.636353636124, 36588.0, 36610.45084323791, 55045.0, 55856.44143558675, 55865.0, 55873.72063139658, 55892.0, 407092.0, 411124.0, 411550.0, 412598.0, 413253.0, 28220.576691349237, 28501.42997140087, 28950.710492895643, 29123.980660676774, 33073.33853322968, 51040.0, 51484.74257628688, 51579.74210128925, 51629.741851290506, 51687.48312516977, 43139.784301078296, 43178.13643727045, 43429.34855977226, 44235.0, 44437.77781111074, 43333.78333108314, 43474.91312717081, 43872.0, 44365.556344437435, 44943.32585011162, 43594.0, 44486.0, 45032.324515131644, 45285.77357113193, 46922.765386172854, 37653.81173094117, 39694.80152599334, 40307.180366038425, 40583.7970810144, 40733.79633101934, 29814.10557683273, 29954.25114372158, 30325.696743032287, 30483.2379190522, 30704.0], "value": 20231.608946100925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4780854612088, 396.6588733689025, 413.7931034482759, 415.38730372700263, 415.58856731835493, 15281.388744450223, 19925.701114483294, 20149.194032238713, 20307.086181121867, 20345.593088138266, 19810.70283945742, 19892.900535497338, 19998.10008549615, 20133.899330503362, 20613.793862061375, 4822.68652537584, 5609.298837645284, 5725.198472213893, 5732.885342293152, 5745.482906538411, 5682.17608446775, 5756.712164391784, 5758.712064396785, 5762.711864406784, 5767.452092051249, 5500.1749737539485, 5659.320881494226, 5683.573731970098, 5688.175214593882, 5725.685087320196, 5545.085060964936, 5597.468240517144, 5611.466910643482, 5613.550915926716, 5614.831555053355, 5076.187809950427, 5316.9734151329385, 5348.973255133738, 5363.088274993261, 5376.8118115865755, 13374.39815208318, 13477.730445391036, 13503.324833758274, 18629.0, 23541.646875296883, 2218.944526386837, 2271.772822717715, 2320.93037208884, 2325.2210509479346, 2395.8083353331867, 10320.741981450525, 10423.218258630557, 10846.132309415307, 10924.344539327587, 15395.923020384938, 1888.6411581799553, 1903.3623736048442, 1927.7204805303152, 1945.601151763885, 1989.383291179739, 85029.0, 85955.0, 90277.0, 91306.5434672829, 91307.63038554427, 8975.192232699088, 9463.148316651397, 9528.380655257524, 11008.889911100787, 11090.55637774496, 12265.754684906253, 12307.4461649226, 12308.938455307667, 12309.93845030787, 12321.93839030799, 7976.960115199387, 8025.518468891768, 8046.798830029179, 8169.550674712829, 8202.835943281101, 8033.1163572007035, 8050.315723163597, 8302.750917472486, 8529.104444033412, 8780.78048048804, 3769.2838360711376, 3797.430385442206, 3823.7323387362617, 3886.553046399644, 3983.183447393277, 1916.6837471817273, 1961.8038196180269, 1976.6244413561378, 1979.3072424651546, 1979.9307024254083, 995.2187532786728, 1009.0061289629709, 1055.6674647486018, 1068.4497483795851, 1094.7372630568607, 19957.20171193136, 21131.683024754642, 21190.0, 21243.150273989177, 21298.57402851965, 1025.825609646362, 1040.9843852342221, 1043.1706793099504, 1057.4501259345097, 1067.7010437077631, 10963.177761667906, 11578.962987876852, 12014.798520147915, 12029.09781766371, 12034.81947770784, 445190.0, 466268.0, 505526.0, 509936.0, 515744.0, 59313.703431482565, 59753.0, 102913.48543257236, 103387.48306258571, 103401.0, 1011.903869132446, 1049.3441599000626, 1072.8658917635296, 1088.8747794003632, 1091.476091476096, 17421.912890435466, 18032.819671803114, 18208.544786380447, 18739.531511712317, 19199.52001199981, 45547.316790248835, 45735.54264457313, 46735.76632116818, 47199.0, 48212.276815847086, 61516.38483615286, 62202.0, 62968.37031629808, 63532.0, 63612.68193659002, 5632.971835140798, 7308.8903666443985, 7328.303811137934, 8733.606987685442, 9054.139856713602, 9897.901020989699, 13529.661758456117, 14309.35607897668, 14388.928055359656, 14631.487897923522, 12009.459574319002, 12307.507699691912, 12509.311987840756, 12641.93679031599, 13133.540326088923, 12311.815322769986, 12636.936815315865, 12644.557440489538, 12879.0, 12925.159864609146, 12392.56626018085, 12456.31490268044, 12639.747205056032, 12723.872761272269, 12866.456025277026, 8752.037275899773, 8783.692570760248, 8842.425242359226, 8863.246624037029, 8945.37382383227, 10088.89911100909, 12169.574064907685, 12195.634130976085, 12296.938515307365, 12449.25304481734], "value": 9221.573504537268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.936372863221, 1516.9014014089084, 1541.5837723814566, 1650.7771450854132, 1816.6820806358876, 7415.777526674195, 8602.61288242029, 8910.643574257021, 8911.910880891197, 9103.863442048374, 8916.643334266622, 8955.596998135083, 9004.234640055603, 9014.819703605925, 9018.909810901889, 2512.5854234051358, 2539.7587229213195, 2543.7201907790127, 2545.5036267927762, 2547.9363015924564, 2504.7119581248116, 2554.8083893707953, 2574.7167811540717, 2575.2789219018705, 2577.5489289374377, 2441.0967941861536, 2442.0598069743187, 2454.3250606083293, 2457.459358941039, 2510.1967370441466, 2380.6786083878715, 2439.2804122783823, 2458.016793282692, 2461.716902556211, 2464.876756162185, 2461.655368248447, 2465.839720418167, 2502.2993561802723, 2503.2740505253455, 2511.045802595002, 8466.365022623328, 8830.86753698695, 8868.733937981806, 8919.554022298858, 8950.32872534556, 5163.173892177234, 5295.7881684732565, 5305.124654432014, 5305.7877684892555, 5311.681299122027, 3401.302732939766, 3437.364087643794, 3495.667911548399, 3505.2288496530723, 3579.821008949542, 1093.5133865429887, 1119.8544189255344, 1133.3256712256277, 1144.633717210493, 1154.4804837823012, 12497.312647804367, 12642.304673242968, 12673.746525069539, 12698.873011269861, 12714.61856144317, 4623.53764623535, 4695.715499453817, 4724.645651576146, 4788.880277993078, 4869.464358920516, 9173.678921237859, 9180.44917304964, 9193.77015574616, 9194.310426718022, 9201.401908875901, 5089.949100508948, 5100.132977393852, 5120.795168193231, 5123.948760512347, 5133.307003554547, 4170.979145104255, 4216.987922898544, 4220.725652832556, 4320.524742278347, 4801.735904525215, 4126.525449573277, 4133.683380416645, 4212.53662097169, 4269.210196113729, 4277.721948073366, 1274.350081458463, 1306.817045613615, 1307.6338625184962, 1312.7177656803833, 1321.7422602592594, 799.5682331540903, 882.5057967538071, 904.5341649050744, 907.9727608171765, 920.2729843423754, 6102.237220347457, 6152.323244443108, 6244.0, 6414.262359828586, 6415.358464153547, 479.6234955559869, 484.0391822232865, 488.94132704075736, 490.22054932656533, 499.79008816297244, 3991.401289806552, 4030.6573941214738, 4053.7973101344814, 4067.91864162721, 4069.959300406958, 10723.731906702238, 11234.719132021764, 11247.887521124847, 11254.0, 11273.0, 11096.500657470433, 11109.666709998713, 11119.999200072032, 11129.72175695598, 11131.944340278247, 8354.66581336752, 8490.19343162411, 8497.61760720769, 8577.185167409087, 8579.65681372738, 5973.49225315853, 5988.4909782668965, 6029.758809647565, 6079.878402431838, 6118.235220597426, 10121.240906932157, 10209.081182693593, 10242.6415075472, 10334.638287659896, 10358.741031473972, 8604.870926935975, 8850.0, 9840.950795245977, 10208.846867297145, 10395.792084158425, 7529.284717951786, 7673.155952845071, 7710.537367757953, 7889.802754931173, 7909.406794490551, 8414.200650938152, 8436.620352084294, 8481.27909127731, 8508.191721786421, 8516.957415213132, 7314.6708398121145, 7515.549067055776, 7527.096748390229, 7609.277118673717, 7685.5004424712215, 7332.706691732485, 7392.075990501187, 7404.370628496638, 7502.962485187539, 7527.585982771, 6724.697388617622, 6883.65581720922, 6890.621015844176, 6895.827604309932, 6899.137607799025, 5138.794448222029, 5230.843074707765, 5276.788928442973, 5366.6243362964215, 5414.891702165856, 5196.194589838581, 5289.444608316071, 5330.360356757214, 5363.168708850135, 5379.435159308373], "value": 4597.018761613397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.20602613987825, 345.59737905340273, 346.83871999520215, 355.6603443711256, 355.9555055618048, 5288.603354748399, 5323.547498462625, 5329.493698098684, 5330.600204984627, 5331.520163185312, 5232.09028704523, 5235.55497782689, 5241.580673546107, 5260.263563101169, 5265.76304066317, 3935.586763389853, 3988.464441190148, 3988.660963818079, 4073.61497090989, 4161.417401563784, 4134.772587507686, 4149.315362965107, 4153.190127925056, 4170.332746760519, 4174.436451079111, 4124.587541245882, 4128.1330920506725, 4130.380442933569, 4137.731047481919, 4151.854685086023, 3858.459815625815, 3871.303165430207, 4092.3247664135383, 4137.81379837908, 4142.855000074983, 3679.889603311878, 3680.5399325084363, 3680.7975561344115, 3686.1153323202507, 3687.9262414751825, 5147.922781158286, 5168.0, 5185.248139019859, 5193.68837869729, 5223.448055322379, 4436.201483732927, 4654.695925516857, 4682.555157260055, 4770.236762118045, 4783.162946484351, 5499.230107784913, 5507.008738427082, 5521.3926468088475, 5532.6680399175775, 5533.78256783507, 3962.385830196324, 3971.8283106483655, 3972.8609498667697, 3975.886751709526, 3984.4820173377275, 5427.701476418795, 5603.7478313475995, 5645.108888522309, 5706.3152421709665, 5779.884402311972, 4000.4999375078114, 4016.357382818735, 4028.441939368522, 4031.314676505001, 4031.637152656275, 4048.2510735513433, 4088.6729061674996, 4095.1809638072505, 4096.8249606555155, 4104.651104656078, 4563.224251877189, 4642.373279607277, 4656.976715116402, 4663.183942809995, 4669.34629151919, 5475.123980163155, 5516.668999860021, 5537.944620553743, 5542.196381524656, 5550.694711790809, 1358.8721361270123, 1363.754524185656, 1368.3295185359302, 1369.5069774881035, 1370.8903287737157, 889.8264838356588, 894.0, 946.5835032585641, 966.2897770138942, 970.8106919150698, 5026.271190677405, 5277.920831187535, 5405.837824865261, 5427.0, 5427.6472029317965, 5633.915491267634, 5634.32388113429, 5650.491455768918, 5656.349519805192, 5662.886742265214, 5270.341207349082, 5398.91901621476, 5412.891742165213, 5425.159100339453, 5426.751847075195, 2851.800373973802, 2862.742353188223, 2864.310057066341, 2877.906395569712, 2887.581300711427, 5689.402612725687, 5699.401562835843, 5714.942850571524, 5734.77060917567, 5736.340320863071, 5301.5493683037375, 5542.5565954723525, 5604.187392828017, 5617.9719101404235, 5638.238837756932, 5665.5467562594895, 5672.631278966854, 5700.800471983461, 5729.991754329094, 5738.942610573841, 5191.8182863599595, 5457.372402173801, 5457.69982650958, 5468.0, 5479.424660410759, 5498.285222921155, 5498.972505137449, 5504.0, 5523.861903452285, 5524.75138618755, 5618.747156378055, 5715.599908006399, 5745.885082298247, 5802.0, 5803.9419605803405, 3792.450094736303, 3970.186111847122, 3974.880753577397, 4035.293823580803, 4038.425992996161, 5630.014747419267, 5657.575681823797, 5660.575456840836, 5667.914981275367, 5679.545636349165, 5551.167324901297, 5566.666000040011, 5569.220309156803, 5580.470849106474, 5584.162375643686, 5418.83743487696, 5435.864103397288, 5483.479069488392, 5488.753006114654, 5508.228847961369, 5444.482774136451, 5459.39946605881, 5476.3702174250475, 5483.588730845123, 5496.532794712494, 5333.759980800795, 5431.619786614899, 5488.890222195613, 5587.217789509553, 5595.608307418442, 5455.3453585568395, 5460.180972854104, 5467.7266136692215, 5475.342958844964, 5476.17857321405], "value": 4193.530291359538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.912385951756, 713.8251128473521, 773.5088218980945, 848.2026894718964, 857.2113655436997, 13752.724945501084, 13927.442902283921, 14258.287085645728, 14644.926775366122, 14653.633659158526, 13263.602091937257, 13292.867071329283, 13376.866231337684, 13418.865811341884, 13433.529826456075, 726.8291951391419, 741.0181509499907, 851.1318455175701, 866.1425189062813, 868.4702331577732, 848.2535368875381, 863.3222920007795, 869.4956924983494, 870.3646338173137, 879.7668617816252, 916.4821875640275, 919.2416256588308, 919.6321471411422, 920.4661296448044, 920.5719340506663, 753.4951582439778, 770.8843673448971, 912.3020889019872, 912.5984566790625, 913.0413066280412, 640.4300172846171, 654.7446495866616, 658.1181217169017, 662.3310456438983, 662.4369286106819, 11923.463444145034, 11954.0, 11972.102092343022, 11979.10156738248, 11993.16047876649, 13057.738845223137, 13189.736205275936, 13496.865031349658, 13566.321683915765, 14191.645208869757, 12700.872991270062, 12716.364181790874, 12813.231206127663, 13057.738845223137, 13122.737545249138, 3909.9413508797393, 3913.5695073541888, 3917.843286268546, 4058.594140585947, 4062.5531191568903, 63024.68487657578, 64742.02886956747, 65329.0, 65338.3466165337, 65908.3409165907, 9873.308868379288, 10088.638033865482, 10118.949405252926, 10247.692569222936, 10332.586696532206, 20336.288229911883, 20455.488612784502, 20496.59006819885, 20697.793022069887, 20914.0, 7565.546067235983, 7688.923110768933, 7713.961430192813, 7901.841963160705, 8075.313598344089, 4589.885252868638, 4723.923018288861, 4792.7124372537755, 4851.369321988119, 4864.416270047617, 3455.274392377629, 3569.37535931211, 3574.1064733816547, 3575.803330816778, 3582.9283414331567, 612.745710530125, 627.5575719118102, 632.7469012394987, 633.3223450907577, 634.7714822663837, 679.9456043516606, 715.3418854653731, 783.9647215875299, 805.6253841963515, 811.9147489513634, 8803.471791692518, 8824.691135810215, 8975.640974361084, 9494.192993595621, 9553.379030363005, 673.6829498330752, 726.2519604807057, 734.1117248129716, 750.0886422996086, 766.7431410477441, 4273.615374616237, 4333.956660433419, 4346.782660866944, 4439.822407103679, 4491.0, 55918.720406397704, 84898.0, 88124.11875881287, 92647.0, 94830.5258473717, 49087.26369104466, 62191.37808621856, 69076.65461672659, 84175.0, 84183.0, 73047.2695273051, 74563.62718186375, 75655.0, 76379.61810190913, 77637.61181194171, 8478.448900821428, 8669.826603468022, 8726.738197854074, 8740.650373984969, 8756.080611535697, 49779.25331119964, 50125.749371254366, 50700.74649626728, 51937.74031129971, 52083.218751718, 57181.0, 57249.42750572441, 58293.0, 63921.68039159774, 67122.66438667971, 13200.471981120647, 13317.267550284827, 13694.863051369359, 13698.109622874481, 13772.449102035805, 14342.784858226927, 15058.924705376403, 15090.849091509384, 15135.318910648826, 16001.279942402387, 11715.88284117182, 13464.25946572948, 13611.387487563281, 13756.931215343859, 14069.507567235507, 12866.614001579968, 13291.601251962456, 13919.860801391857, 13935.58193254204, 14415.78376324377, 12814.0, 13043.804342935053, 13509.0, 13668.248246346546, 14072.085314454527, 10116.03897629724, 10187.286889917634, 10214.131798797185, 10754.797356871799, 10803.243772935819, 10230.539625716712, 10990.725231869268, 11164.776704465703, 11194.552217911192, 11295.887041129483], "value": 7204.007750679352, "unit": "score"}], "name": "dromaeo_css", "value": 7213.996639005657, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 120.0, 152.0, 125.0, 118.0, 118.0, 124.0, 150.0, 120.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 161.0, 159.0, 161.0, 158.0, 161.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 118.0, 76.0, 77.0, 74.0, 76.0, 99.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 82.0, 83.0, 82.0, 115.0, 82.0, 81.0, 121.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 53.0, 50.0, 52.0, 52.0, 50.0, 51.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 63.0, 60.0, 61.0, 59.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 83.0, 75.0, 75.0, 75.0, 74.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 123.0, 124.0, 120.0, 137.0, 119.0, 128.0, 170.0, 127.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 153.0, 150.0, 158.0, 161.0, 158.0, 153.0, 157.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 62.0, 62.0, 63.0, 62.0, 64.0, 63.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1456.1, "alertThreshold": 2.0}]} 09:13:35 INFO - Return code: 0 09:13:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:35 INFO - # TBPL SUCCESS # 09:13:35 INFO - Running post-action listener: _resource_record_post_action 09:13:35 INFO - [mozharness: 2016-12-30 17:13:35.684547Z] Finished run-tests step (success) 09:13:35 INFO - Running post-run listener: _resource_record_post_run 09:13:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 462848; Write bytes: 356585472; Read time: 84; Write time: 292464 09:13:35 INFO - TinderboxPrint: CPU usage
13.0% 09:13:35 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 84 09:13:35 INFO - TinderboxPrint: I/O write bytes / time
356,585,472 / 292,464 09:13:35 INFO - TinderboxPrint: CPU idle
8,278.6 (87.0%) 09:13:35 INFO - TinderboxPrint: CPU user
1,189.8 (12.5%) 09:13:35 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109690880; Read time: 0; Write time: 124824 09:13:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 458752; Write bytes: 246894592; Read time: 76; Write time: 167640 09:13:36 INFO - Running post-run listener: _upload_blobber_files 09:13:36 INFO - Blob upload gear active. 09:13:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:13:36 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:37 INFO - (blobuploader) - INFO - Done attempting. 09:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:40 INFO - (blobuploader) - INFO - Done attempting. 09:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:41 INFO - (blobuploader) - INFO - Done attempting. 09:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:41 INFO - Return code: 0 09:13:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d49fa7514994b3af96b4f0b6607323640e2e63a9629a95f4d4032c441faa9a0a0737be627179f477cf2f5eb6916205c98fdcab14becfd13a4919c1f4ebcc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18ad7256e26bd144c428da2a6afce14ed246f13ad206bd9fb5f4d0c32c3798a9997dd82549fe6bf6e92d2c008602eb3fef69fb20431f0d0b16978ff88c737f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a332715e2ea4b96192233478ee44582782f4dba7840026683574f5b69f10702b386d5b50db28810c1b3aefaab55dd6e9d33c6413d0b5e2f13d549edc141deac"} 09:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:41 INFO - Contents: 09:13:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d49fa7514994b3af96b4f0b6607323640e2e63a9629a95f4d4032c441faa9a0a0737be627179f477cf2f5eb6916205c98fdcab14becfd13a4919c1f4ebcc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18ad7256e26bd144c428da2a6afce14ed246f13ad206bd9fb5f4d0c32c3798a9997dd82549fe6bf6e92d2c008602eb3fef69fb20431f0d0b16978ff88c737f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a332715e2ea4b96192233478ee44582782f4dba7840026683574f5b69f10702b386d5b50db28810c1b3aefaab55dd6e9d33c6413d0b5e2f13d549edc141deac"} 09:13:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:41 INFO - Copying logs to upload dir... 09:13:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.936959 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-30 09:13:41.526813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 09:13:41.530455) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d49fa7514994b3af96b4f0b6607323640e2e63a9629a95f4d4032c441faa9a0a0737be627179f477cf2f5eb6916205c98fdcab14becfd13a4919c1f4ebcc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18ad7256e26bd144c428da2a6afce14ed246f13ad206bd9fb5f4d0c32c3798a9997dd82549fe6bf6e92d2c008602eb3fef69fb20431f0d0b16978ff88c737f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a332715e2ea4b96192233478ee44582782f4dba7840026683574f5b69f10702b386d5b50db28810c1b3aefaab55dd6e9d33c6413d0b5e2f13d549edc141deac"} build_url:https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/aC8xgqJkQKWnF7LvjVCAWw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d49fa7514994b3af96b4f0b6607323640e2e63a9629a95f4d4032c441faa9a0a0737be627179f477cf2f5eb6916205c98fdcab14becfd13a4919c1f4ebcc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18ad7256e26bd144c428da2a6afce14ed246f13ad206bd9fb5f4d0c32c3798a9997dd82549fe6bf6e92d2c008602eb3fef69fb20431f0d0b16978ff88c737f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a332715e2ea4b96192233478ee44582782f4dba7840026683574f5b69f10702b386d5b50db28810c1b3aefaab55dd6e9d33c6413d0b5e2f13d549edc141deac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 09:13:41.555167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:13:41.555465) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483116784.888472-225570060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:13:41.637952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 09:13:41.638289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 09:13:41.638676) ========= ========= Total master_lag: 0.17 =========