builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1484033556.07 results: success (0) buildid: 20170109215908 builduid: 9a8baa0b73944e50950850ff139ca445 revision: 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.072680) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.073741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.074040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.109063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.109322) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 23:32:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-01-09 23:32:37 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.243551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.243883) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015234 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.305183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:36.305552) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 --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 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 --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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 23:32:37,408 truncating revision to first 12 chars 2017-01-09 23:32:37,408 Setting DEBUG logging. 2017-01-09 23:32:37,408 attempt 1/10 2017-01-09 23:32:37,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/091c74eb5714?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 23:32:37,791 unpacking tar archive at: mozilla-aurora-091c74eb5714/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:37.039776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:37.040082) ========= script_repo_revision: 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:37.040746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:37.041047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 23:32:37.053361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-09 23:32:37.053650) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:32:38 INFO - MultiFileLogger online at 20170109 23:32:38 in /builds/slave/test 23:32:38 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 23:32:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:32:38 INFO - {'append_to_log': False, 23:32:38 INFO - 'base_work_dir': '/builds/slave/test', 23:32:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:32:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:32:38 INFO - 'branch': 'Mozilla-Aurora', 23:32:38 INFO - 'buildbot_json_path': 'buildprops.json', 23:32:38 INFO - 'config_files': ('talos/linux_config.py',), 23:32:38 INFO - 'default_actions': ('clobber', 23:32:38 INFO - 'read-buildbot-config', 23:32:38 INFO - 'download-and-extract', 23:32:38 INFO - 'populate-webroot', 23:32:38 INFO - 'create-virtualenv', 23:32:38 INFO - 'install', 23:32:38 INFO - 'run-tests'), 23:32:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:32:38 INFO - 'download_minidump_stackwalk': True, 23:32:38 INFO - 'download_symbols': 'ondemand', 23:32:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:32:38 INFO - 'tooltool.py': '/tools/tooltool.py', 23:32:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:32:38 INFO - '/tools/misc-python/virtualenv.py')}, 23:32:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:32:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:32:38 INFO - 'installer_path': 'installer.exe', 23:32:38 INFO - 'log_level': 'info', 23:32:38 INFO - 'log_name': 'talos', 23:32:38 INFO - 'log_to_console': True, 23:32:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:32:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:32:38 INFO - 'opt_config_files': (), 23:32:38 INFO - 'pip_index': False, 23:32:38 INFO - 'sps_profile': False, 23:32:38 INFO - 'sps_profile_interval': 0, 23:32:38 INFO - 'suite': 'dromaeojs', 23:32:38 INFO - 'system_bits': '32', 23:32:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:32:38 INFO - 'title': 'talos-linux64-ix-067', 23:32:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:32:38 INFO - 'use_talos_json': True, 23:32:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:32:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:32:38 INFO - 'work_dir': 'build'} 23:32:38 INFO - [mozharness: 2017-01-10 07:32:38.258767Z] Running clobber step. 23:32:38 INFO - Running pre-action listener: _resource_record_pre_action 23:32:38 INFO - Running main action method: clobber 23:32:38 INFO - rmtree: /builds/slave/test/build 23:32:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:32:39 INFO - Running post-action listener: _resource_record_post_action 23:32:39 INFO - [mozharness: 2017-01-10 07:32:39.242570Z] Finished clobber step (success) 23:32:39 INFO - [mozharness: 2017-01-10 07:32:39.242679Z] Running read-buildbot-config step. 23:32:39 INFO - Running pre-action listener: _resource_record_pre_action 23:32:39 INFO - Running main action method: read_buildbot_config 23:32:39 INFO - Using buildbot properties: 23:32:39 INFO - { 23:32:39 INFO - "project": "", 23:32:39 INFO - "product": "firefox", 23:32:39 INFO - "script_repo_revision": "production", 23:32:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:32:39 INFO - "repository": "", 23:32:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:32:39 INFO - "buildid": "20170109215908", 23:32:39 INFO - "pgo_build": "True", 23:32:39 INFO - "basedir": "/builds/slave/test", 23:32:39 INFO - "buildnumber": 723, 23:32:39 INFO - "slavename": "talos-linux64-ix-067", 23:32:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:32:39 INFO - "platform": "ubuntu64_hw", 23:32:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:32:39 INFO - "branch": "mozilla-aurora", 23:32:39 INFO - "repo_path": "releases/mozilla-aurora", 23:32:39 INFO - "revision": "091c74eb5714ac9e211e76c8809e4c3e2b8b98b2", 23:32:39 INFO - "stage_platform": "linux64-pgo", 23:32:39 INFO - "builduid": "9a8baa0b73944e50950850ff139ca445", 23:32:39 INFO - "slavebuilddir": "test" 23:32:39 INFO - } 23:32:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 23:32:39 INFO - Running post-action listener: _resource_record_post_action 23:32:39 INFO - [mozharness: 2017-01-10 07:32:39.245293Z] Finished read-buildbot-config step (success) 23:32:39 INFO - [mozharness: 2017-01-10 07:32:39.245381Z] Running download-and-extract step. 23:32:39 INFO - Running pre-action listener: _resource_record_pre_action 23:32:39 INFO - Running main action method: download_and_extract 23:32:39 INFO - mkdir: /builds/slave/test/build/tests 23:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:39 INFO - trying https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 23:32:39 INFO - Downloading https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/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 23:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/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 23:32:39 INFO - Downloaded 1361 bytes. 23:32:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 23:32:39 INFO - Using the following test package requirements: 23:32:39 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 23:32:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:32:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:32:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'jsshell-linux-x86_64.zip'], 23:32:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:32:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 23:32:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:32:39 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:32:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:32:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:32:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:32:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 23:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:32:40 INFO - Http code: 200 23:32:40 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 23:32:40 INFO - x-amz-cf-id: Plgvq9l2EF66fK1Lm1gWdbdXj_Pv_LdgCUmvF2djFwPzuQaYImkdNA== 23:32:40 INFO - x-amz-version-id: p8Ck3d6z7E9kwnm1doRnQ.Y_vu9zaRoV 23:32:40 INFO - Expected file size: 21944611 23:32:40 INFO - Obtained file size: 21944611 23:32:44 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 23:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 23:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:32:45 INFO - Http code: 200 23:32:45 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 23:32:45 INFO - x-amz-cf-id: ChCGkKI0Kk3qMx4hH046csjsq_Qh_k-Jstqujq1eRZPl-4O0sGrUew== 23:32:45 INFO - x-amz-version-id: p8Ck3d6z7E9kwnm1doRnQ.Y_vu9zaRoV 23:32:45 INFO - Expected file size: 21944611 23:32:45 INFO - Obtained file size: 21944611 23:32:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 23:32:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:32:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 23:32:50 INFO - Http code: 200 23:32:50 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 23:32:50 INFO - x-amz-cf-id: RVMw1pXvMp--FiQUNW7tmNKrx7ASrb9VvXfmuPUvNarNlb0atjuZtA== 23:32:50 INFO - x-amz-version-id: lYSSVTu1yPalSOWB_9PdyWPb1nzc5Wq_ 23:32:50 INFO - Expected file size: 14409038 23:32:50 INFO - Obtained file size: 14409038 23:32:51 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')]} 23:32:51 INFO - trying https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/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 23:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/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 23:32:52 INFO - Downloaded 64093084 bytes. 23:32:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:32:52 INFO - mkdir: /builds/slave/test/properties 23:32:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:32:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:32:52 INFO - Contents: 23:32:52 INFO - build_url:https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:32:53 INFO - Running post-action listener: _resource_record_post_action 23:32:53 INFO - Running post-action listener: set_extra_try_arguments 23:32:53 INFO - [mozharness: 2017-01-10 07:32:53.255837Z] Finished download-and-extract step (success) 23:32:53 INFO - [mozharness: 2017-01-10 07:32:53.256064Z] Running populate-webroot step. 23:32:53 INFO - Running pre-action listener: _resource_record_pre_action 23:32:53 INFO - Running main action method: populate_webroot 23:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:32:53 INFO - '--tppagecycles', 23:32:53 INFO - '7'], 23:32:53 INFO - 'tests': ['tsvgm']}}, 23:32:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:32:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:32:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:32:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['damp', 'tps']}, 23:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'tests': ['damp', 'tps']}, 23:32:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['dromaeo_dom']}, 23:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:32:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['basic_compositor_video']}, 23:32:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:32:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'other-e10s': {'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['a11yr', 23:32:53 INFO - 'ts_paint', 23:32:53 INFO - 'tpaint', 23:32:53 INFO - 'sessionrestore', 23:32:53 INFO - 'sessionrestore_no_auto_restore', 23:32:53 INFO - 'tabpaint']}, 23:32:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['tsvgx', 23:32:53 INFO - 'tsvgr_opacity', 23:32:53 INFO - 'tart', 23:32:53 INFO - 'tscrollx', 23:32:53 INFO - 'cart']}, 23:32:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:32:53 INFO - 'tsvgr_opacity', 23:32:53 INFO - 'tart', 23:32:53 INFO - 'tscrollx', 23:32:53 INFO - 'cart']}, 23:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'talos_options': ['--disable-e10s'], 23:32:53 INFO - 'tests': ['tp5o']}, 23:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'tests': ['tp5o']}, 23:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'talos_options': ['--disable-e10s', 23:32:53 INFO - '--xperf_path', 23:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:53 INFO - 'tests': ['tp5n']}, 23:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:53 INFO - 'talos_options': ['--xperf_path', 23:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:53 INFO - 'tests': ['tp5n']}}, 23:32:53 INFO - 'talos.zip': {'path': '', 23:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:32:53 INFO - Running post-action listener: _resource_record_post_action 23:32:53 INFO - [mozharness: 2017-01-10 07:32:53.273334Z] Finished populate-webroot step (success) 23:32:53 INFO - [mozharness: 2017-01-10 07:32:53.273422Z] Running create-virtualenv step. 23:32:53 INFO - Running pre-action listener: _resource_record_pre_action 23:32:53 INFO - Running main action method: create_virtualenv 23:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 23:32:53 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 23:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:32:53 INFO - Using real prefix '/usr' 23:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:32:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:32:55 INFO - Installing pip.................done. 23:32:55 INFO - Return code: 0 23:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:32:56 INFO - Reading from file tmpfile_stdout 23:32:56 INFO - Output received: 23:32:56 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) 23:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:32:56 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')]} 23:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:56 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')]} 23:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:56 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:32:56 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 23:32:56 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 23:32:56 INFO - Using env: {'DISPLAY': ':0', 23:32:56 INFO - 'HOME': '/home/cltbld', 23:32:56 INFO - 'LANG': 'en_US.UTF-8', 23:32:56 INFO - 'LANGUAGE': 'en_US:en', 23:32:56 INFO - 'LOGNAME': 'cltbld', 23:32:56 INFO - 'MAIL': '/var/mail/cltbld', 23:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:56 INFO - 'MOZ_NO_REMOTE': '1', 23:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:56 INFO - 'NO_EM_RESTART': '1', 23:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:56 INFO - 'PWD': '/builds/slave/test', 23:32:56 INFO - 'SHELL': '/bin/bash', 23:32:56 INFO - 'SHLVL': '1', 23:32:56 INFO - 'TERM': 'linux', 23:32:56 INFO - 'TMOUT': '86400', 23:32:56 INFO - 'USER': 'cltbld', 23:32:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:56 INFO - '_': '/tools/buildbot/bin/python'} 23:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:56 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 23:32:56 INFO - Cleaning up... 23:32:56 INFO - Return code: 0 23:32:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:32:56 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')]} 23:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:56 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')]} 23:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:56 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:32:56 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 23:32:56 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 23:32:56 INFO - Using env: {'DISPLAY': ':0', 23:32:56 INFO - 'HOME': '/home/cltbld', 23:32:56 INFO - 'LANG': 'en_US.UTF-8', 23:32:56 INFO - 'LANGUAGE': 'en_US:en', 23:32:56 INFO - 'LOGNAME': 'cltbld', 23:32:56 INFO - 'MAIL': '/var/mail/cltbld', 23:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:56 INFO - 'MOZ_NO_REMOTE': '1', 23:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:56 INFO - 'NO_EM_RESTART': '1', 23:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:56 INFO - 'PWD': '/builds/slave/test', 23:32:56 INFO - 'SHELL': '/bin/bash', 23:32:56 INFO - 'SHLVL': '1', 23:32:56 INFO - 'TERM': 'linux', 23:32:56 INFO - 'TMOUT': '86400', 23:32:56 INFO - 'USER': 'cltbld', 23:32:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:56 INFO - '_': '/tools/buildbot/bin/python'} 23:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:56 INFO - Downloading/unpacking psutil>=3.1.1 23:32:56 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 23:32:56 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 23:32:56 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 23:32:56 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 23:32:56 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 23:32:56 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 23:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:58 INFO - Installing collected packages: psutil 23:32:58 INFO - Running setup.py install for psutil 23:32:58 INFO - building 'psutil._psutil_linux' extension 23:32:58 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 23:32:58 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 23:32:58 INFO - building 'psutil._psutil_posix' extension 23:32:58 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 23:32:58 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 23:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:59 INFO - Successfully installed psutil 23:32:59 INFO - Cleaning up... 23:32:59 INFO - Return code: 0 23:32:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:32: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')]} 23:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32: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')]} 23:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:32:59 INFO - Using env: {'DISPLAY': ':0', 23:32:59 INFO - 'HOME': '/home/cltbld', 23:32:59 INFO - 'LANG': 'en_US.UTF-8', 23:32:59 INFO - 'LANGUAGE': 'en_US:en', 23:32:59 INFO - 'LOGNAME': 'cltbld', 23:32:59 INFO - 'MAIL': '/var/mail/cltbld', 23:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:59 INFO - 'MOZ_NO_REMOTE': '1', 23:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:59 INFO - 'NO_EM_RESTART': '1', 23:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:59 INFO - 'PWD': '/builds/slave/test', 23:32:59 INFO - 'SHELL': '/bin/bash', 23:32:59 INFO - 'SHLVL': '1', 23:32:59 INFO - 'TERM': 'linux', 23:32:59 INFO - 'TMOUT': '86400', 23:32:59 INFO - 'USER': 'cltbld', 23:32:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:59 INFO - '_': '/tools/buildbot/bin/python'} 23:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:32:59 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 23:32:59 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 23:32:59 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 23:32:59 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 23:32:59 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 23:32:59 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 23:33:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:33:01 INFO - Installing collected packages: mozsystemmonitor 23:33:01 INFO - Running setup.py install for mozsystemmonitor 23:33:01 INFO - Successfully installed mozsystemmonitor 23:33:01 INFO - Cleaning up... 23:33:01 INFO - Return code: 0 23:33:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:33:01 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')]} 23:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:01 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')]} 23:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:01 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:01 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 23:33:01 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 23:33:01 INFO - Using env: {'DISPLAY': ':0', 23:33:01 INFO - 'HOME': '/home/cltbld', 23:33:01 INFO - 'LANG': 'en_US.UTF-8', 23:33:01 INFO - 'LANGUAGE': 'en_US:en', 23:33:01 INFO - 'LOGNAME': 'cltbld', 23:33:01 INFO - 'MAIL': '/var/mail/cltbld', 23:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:01 INFO - 'MOZ_NO_REMOTE': '1', 23:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:01 INFO - 'NO_EM_RESTART': '1', 23:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:01 INFO - 'PWD': '/builds/slave/test', 23:33:01 INFO - 'SHELL': '/bin/bash', 23:33:01 INFO - 'SHLVL': '1', 23:33:01 INFO - 'TERM': 'linux', 23:33:01 INFO - 'TMOUT': '86400', 23:33:01 INFO - 'USER': 'cltbld', 23:33:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:01 INFO - '_': '/tools/buildbot/bin/python'} 23:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:33:01 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 23:33:01 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 23:33:01 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 23:33:01 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 23:33:01 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 23:33:01 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 23:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:33:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:33:04 INFO - warning: no files found matching '*.txt' 23:33:04 INFO - no previously-included directories found matching 'build' 23:33:04 INFO - no previously-included directories found matching 'dist' 23:33:04 INFO - no previously-included directories found matching '.git*' 23:33:04 INFO - Installing collected packages: jsonschema, functools32 23:33:04 INFO - Running setup.py install for functools32 23:33:04 INFO - warning: no files found matching '*.txt' 23:33:04 INFO - no previously-included directories found matching 'build' 23:33:04 INFO - no previously-included directories found matching 'dist' 23:33:04 INFO - no previously-included directories found matching '.git*' 23:33:04 INFO - Successfully installed jsonschema functools32 23:33:04 INFO - Cleaning up... 23:33:04 INFO - Return code: 0 23:33:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:33:04 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')]} 23:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 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')]} 23:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:04 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 23:33:04 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 23:33:04 INFO - Using env: {'DISPLAY': ':0', 23:33:04 INFO - 'HOME': '/home/cltbld', 23:33:04 INFO - 'LANG': 'en_US.UTF-8', 23:33:04 INFO - 'LANGUAGE': 'en_US:en', 23:33:04 INFO - 'LOGNAME': 'cltbld', 23:33:04 INFO - 'MAIL': '/var/mail/cltbld', 23:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:04 INFO - 'MOZ_NO_REMOTE': '1', 23:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:04 INFO - 'NO_EM_RESTART': '1', 23:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:04 INFO - 'PWD': '/builds/slave/test', 23:33:04 INFO - 'SHELL': '/bin/bash', 23:33:04 INFO - 'SHLVL': '1', 23:33:04 INFO - 'TERM': 'linux', 23:33:04 INFO - 'TMOUT': '86400', 23:33:04 INFO - 'USER': 'cltbld', 23:33:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:04 INFO - '_': '/tools/buildbot/bin/python'} 23:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:33:04 INFO - Cleaning up... 23:33:04 INFO - Return code: 0 23:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:33:04 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')]} 23:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 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')]} 23:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:04 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:04 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 23:33:04 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 23:33:04 INFO - Using env: {'DISPLAY': ':0', 23:33:04 INFO - 'HOME': '/home/cltbld', 23:33:04 INFO - 'LANG': 'en_US.UTF-8', 23:33:04 INFO - 'LANGUAGE': 'en_US:en', 23:33:04 INFO - 'LOGNAME': 'cltbld', 23:33:04 INFO - 'MAIL': '/var/mail/cltbld', 23:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:04 INFO - 'MOZ_NO_REMOTE': '1', 23:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:04 INFO - 'NO_EM_RESTART': '1', 23:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:04 INFO - 'PWD': '/builds/slave/test', 23:33:04 INFO - 'SHELL': '/bin/bash', 23:33:04 INFO - 'SHLVL': '1', 23:33:04 INFO - 'TERM': 'linux', 23:33:04 INFO - 'TMOUT': '86400', 23:33:04 INFO - 'USER': 'cltbld', 23:33:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:04 INFO - '_': '/tools/buildbot/bin/python'} 23:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:33:04 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 23:33:04 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 23:33:04 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 23:33:04 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 23:33:04 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 23:33:04 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 23:33:06 INFO - Downloading blobuploader-1.2.4.tar.gz 23:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:33:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:33:06 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 23:33:06 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 23:33:06 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 23:33:06 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 23:33:06 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 23:33:06 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 23:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:07 INFO - Downloading docopt-0.6.1.tar.gz 23:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:33:07 INFO - Installing collected packages: blobuploader, requests, docopt 23:33:07 INFO - Running setup.py install for blobuploader 23:33:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:33:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:33:07 INFO - Running setup.py install for requests 23:33:07 INFO - Running setup.py install for docopt 23:33:08 INFO - Successfully installed blobuploader requests docopt 23:33:08 INFO - Cleaning up... 23:33:08 INFO - Return code: 0 23:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:08 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')]} 23:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:08 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')]} 23:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:08 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:08 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 23:33:08 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 23:33:08 INFO - Using env: {'DISPLAY': ':0', 23:33:08 INFO - 'HOME': '/home/cltbld', 23:33:08 INFO - 'LANG': 'en_US.UTF-8', 23:33:08 INFO - 'LANGUAGE': 'en_US:en', 23:33:08 INFO - 'LOGNAME': 'cltbld', 23:33:08 INFO - 'MAIL': '/var/mail/cltbld', 23:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:08 INFO - 'MOZ_NO_REMOTE': '1', 23:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:08 INFO - 'NO_EM_RESTART': '1', 23:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:08 INFO - 'PWD': '/builds/slave/test', 23:33:08 INFO - 'SHELL': '/bin/bash', 23:33:08 INFO - 'SHLVL': '1', 23:33:08 INFO - 'TERM': 'linux', 23:33:08 INFO - 'TMOUT': '86400', 23:33:08 INFO - 'USER': 'cltbld', 23:33:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:08 INFO - '_': '/tools/buildbot/bin/python'} 23:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:08 INFO - Running setup.py (path:/tmp/pip-rn5Obr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:08 INFO - Running setup.py (path:/tmp/pip-ycrAwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:08 INFO - Running setup.py (path:/tmp/pip-vzjpTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:08 INFO - Running setup.py (path:/tmp/pip-IL72oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:08 INFO - Running setup.py (path:/tmp/pip-XM_CRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:08 INFO - Running setup.py (path:/tmp/pip-sqRzP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:08 INFO - Running setup.py (path:/tmp/pip-ugLNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:08 INFO - Running setup.py (path:/tmp/pip-UdILso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:08 INFO - Running setup.py (path:/tmp/pip-K5QL2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:09 INFO - Running setup.py (path:/tmp/pip-djuYX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:09 INFO - Running setup.py (path:/tmp/pip-rMv3by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:09 INFO - Running setup.py (path:/tmp/pip-xBa1Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:09 INFO - Running setup.py (path:/tmp/pip-ufhCLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:09 INFO - Running setup.py (path:/tmp/pip-qAp1OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:09 INFO - Running setup.py (path:/tmp/pip-7p30bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:09 INFO - Running setup.py (path:/tmp/pip-1NiNFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:09 INFO - Running setup.py (path:/tmp/pip-V0TkE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:33:09 INFO - Running setup.py install for manifestparser 23:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:33:09 INFO - Running setup.py install for mozcrash 23:33:09 INFO - Running setup.py install for mozdebug 23:33:09 INFO - Running setup.py install for mozdevice 23:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozfile 23:33:10 INFO - Running setup.py install for mozhttpd 23:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozinfo 23:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozInstall 23:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozleak 23:33:10 INFO - Running setup.py install for mozlog 23:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for moznetwork 23:33:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozprocess 23:33:10 INFO - Running setup.py install for mozprofile 23:33:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:33:10 INFO - Running setup.py install for mozrunner 23:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Running setup.py install for mozscreenshot 23:33:11 INFO - Running setup.py install for moztest 23:33:11 INFO - Running setup.py install for mozversion 23:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:33:11 INFO - Cleaning up... 23:33:11 INFO - Return code: 0 23:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:11 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:11 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 23:33:11 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 23:33:11 INFO - Using env: {'DISPLAY': ':0', 23:33:11 INFO - 'HOME': '/home/cltbld', 23:33:11 INFO - 'LANG': 'en_US.UTF-8', 23:33:11 INFO - 'LANGUAGE': 'en_US:en', 23:33:11 INFO - 'LOGNAME': 'cltbld', 23:33:11 INFO - 'MAIL': '/var/mail/cltbld', 23:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:11 INFO - 'MOZ_NO_REMOTE': '1', 23:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:11 INFO - 'NO_EM_RESTART': '1', 23:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:11 INFO - 'PWD': '/builds/slave/test', 23:33:11 INFO - 'SHELL': '/bin/bash', 23:33:11 INFO - 'SHLVL': '1', 23:33:11 INFO - 'TERM': 'linux', 23:33:11 INFO - 'TMOUT': '86400', 23:33:11 INFO - 'USER': 'cltbld', 23:33:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:11 INFO - '_': '/tools/buildbot/bin/python'} 23:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:11 INFO - Running setup.py (path:/tmp/pip-eV1tSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:11 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)) 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:11 INFO - Running setup.py (path:/tmp/pip-pq6t9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:11 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)) 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:11 INFO - Running setup.py (path:/tmp/pip-DoGN_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:11 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)) 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:11 INFO - Running setup.py (path:/tmp/pip-CqyDJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:11 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)) 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:11 INFO - Running setup.py (path:/tmp/pip-Uh9NpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:11 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)) 23:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:11 INFO - Running setup.py (path:/tmp/pip-74Q3Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:12 INFO - Running setup.py (path:/tmp/pip-sJciDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:12 INFO - Running setup.py (path:/tmp/pip-xDJUiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:12 INFO - Running setup.py (path:/tmp/pip-ncqmEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:12 INFO - Running setup.py (path:/tmp/pip-PcSpLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:12 INFO - Running setup.py (path:/tmp/pip-smWnbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:12 INFO - Running setup.py (path:/tmp/pip-D4AEYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:12 INFO - Running setup.py (path:/tmp/pip-NLJhly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:12 INFO - Running setup.py (path:/tmp/pip-qUPqIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:12 INFO - Running setup.py (path:/tmp/pip-kOvExn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:12 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:12 INFO - Running setup.py (path:/tmp/pip-0SB6L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 23:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:12 INFO - Running setup.py (path:/tmp/pip-G_5Tnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:12 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)) 23:33:12 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)) 23:33:12 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)) 23:33:12 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)) 23:33:12 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)) 23:33:12 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)) 23:33:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:33:12 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 23:33:12 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 23:33:12 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 23:33:12 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 23:33:12 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 23:33:12 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 23:33:14 INFO - Downloading blessings-1.6.tar.gz 23:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:33:14 INFO - Installing collected packages: blessings 23:33:14 INFO - Running setup.py install for blessings 23:33:15 INFO - Successfully installed blessings 23:33:15 INFO - Cleaning up... 23:33:15 INFO - Return code: 0 23:33:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:15 INFO - Reading from file tmpfile_stdout 23:33:15 INFO - Current package versions: 23:33:15 INFO - argparse == 1.2.1 23:33:15 INFO - blessings == 1.6 23:33:15 INFO - blobuploader == 1.2.4 23:33:15 INFO - docopt == 0.6.1 23:33:15 INFO - functools32 == 3.2.3-2 23:33:15 INFO - jsonschema == 2.5.1 23:33:15 INFO - manifestparser == 1.1 23:33:15 INFO - mozInstall == 1.12 23:33:15 INFO - mozcrash == 1.0 23:33:15 INFO - mozdebug == 0.1 23:33:15 INFO - mozdevice == 0.48 23:33:15 INFO - mozfile == 1.2 23:33:15 INFO - mozhttpd == 0.7 23:33:15 INFO - mozinfo == 0.9 23:33:15 INFO - mozleak == 0.1 23:33:15 INFO - mozlog == 3.4 23:33:15 INFO - moznetwork == 0.27 23:33:15 INFO - mozprocess == 0.23 23:33:15 INFO - mozprofile == 0.28 23:33:15 INFO - mozrunner == 6.13 23:33:15 INFO - mozscreenshot == 0.1 23:33:15 INFO - mozsystemmonitor == 0.3 23:33:15 INFO - moztest == 0.8 23:33:15 INFO - mozversion == 1.4 23:33:15 INFO - psutil == 3.1.1 23:33:15 INFO - requests == 1.2.3 23:33:15 INFO - wsgiref == 0.1.2 23:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:15 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')]} 23:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 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')]} 23:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:15 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 23:33:15 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 23:33:15 INFO - Using env: {'DISPLAY': ':0', 23:33:15 INFO - 'HOME': '/home/cltbld', 23:33:15 INFO - 'LANG': 'en_US.UTF-8', 23:33:15 INFO - 'LANGUAGE': 'en_US:en', 23:33:15 INFO - 'LOGNAME': 'cltbld', 23:33:15 INFO - 'MAIL': '/var/mail/cltbld', 23:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:15 INFO - 'MOZ_NO_REMOTE': '1', 23:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:15 INFO - 'NO_EM_RESTART': '1', 23:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:15 INFO - 'PWD': '/builds/slave/test', 23:33:15 INFO - 'SHELL': '/bin/bash', 23:33:15 INFO - 'SHLVL': '1', 23:33:15 INFO - 'TERM': 'linux', 23:33:15 INFO - 'TMOUT': '86400', 23:33:15 INFO - 'USER': 'cltbld', 23:33:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:15 INFO - '_': '/tools/buildbot/bin/python'} 23:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 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)) 23:33:15 INFO - Cleaning up... 23:33:15 INFO - Return code: 0 23:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:33:15 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')]} 23:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 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')]} 23:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:15 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 0x7f170269af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', '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 23:33:15 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 23:33:15 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 23:33:15 INFO - Using env: {'DISPLAY': ':0', 23:33:15 INFO - 'HOME': '/home/cltbld', 23:33:15 INFO - 'LANG': 'en_US.UTF-8', 23:33:15 INFO - 'LANGUAGE': 'en_US:en', 23:33:15 INFO - 'LOGNAME': 'cltbld', 23:33:15 INFO - 'MAIL': '/var/mail/cltbld', 23:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:15 INFO - 'MOZ_NO_REMOTE': '1', 23:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:15 INFO - 'NO_EM_RESTART': '1', 23:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:15 INFO - 'PWD': '/builds/slave/test', 23:33:15 INFO - 'SHELL': '/bin/bash', 23:33:15 INFO - 'SHLVL': '1', 23:33:15 INFO - 'TERM': 'linux', 23:33:15 INFO - 'TMOUT': '86400', 23:33:15 INFO - 'USER': 'cltbld', 23:33:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:15 INFO - '_': '/tools/buildbot/bin/python'} 23:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:33:15 INFO - Cleaning up... 23:33:15 INFO - Return code: 0 23:33:15 INFO - Running post-action listener: _resource_record_post_action 23:33:15 INFO - Running post-action listener: _start_resource_monitoring 23:33:15 INFO - Starting resource monitoring. 23:33:15 INFO - [mozharness: 2017-01-10 07:33:15.820640Z] Finished create-virtualenv step (success) 23:33:15 INFO - [mozharness: 2017-01-10 07:33:15.821096Z] Running install step. 23:33:15 INFO - Running pre-action listener: _resource_record_pre_action 23:33:15 INFO - Running main action method: install 23:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:16 INFO - Reading from file tmpfile_stdout 23:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:33:16 INFO - Reading from file tmpfile_stdout 23:33:16 INFO - Output received: 23:33:16 INFO - Usage: mozinstall [options] installer 23:33:16 INFO - Options: 23:33:16 INFO - -h, --help show this help message and exit 23:33:16 INFO - -d DEST, --destination=DEST 23:33:16 INFO - Directory to install application into. [default: 23:33:16 INFO - "/builds/slave/test"] 23:33:16 INFO - --app=APP Application being installed. [default: firefox] 23:33:16 INFO - mkdir: /builds/slave/test/build/application 23:33:16 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'] 23:33:16 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 23:33:32 INFO - Reading from file tmpfile_stdout 23:33:32 INFO - Output received: 23:33:32 INFO - /builds/slave/test/build/application/firefox/firefox 23:33:32 INFO - Running post-action listener: _resource_record_post_action 23:33:32 INFO - [mozharness: 2017-01-10 07:33:32.053569Z] Finished install step (success) 23:33:32 INFO - [mozharness: 2017-01-10 07:33:32.053814Z] Running run-tests step. 23:33:32 INFO - Running pre-action listener: _resource_record_pre_action 23:33:32 INFO - Running main action method: run_tests 23:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:33:32 INFO - Python 2.7.3 23:33:32 INFO - Return code: 0 23:33:32 INFO - grabbing minidump binary from tooltool 23:33:32 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')]} 23:33:32 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 0x180cf60>, '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 0x180dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:33:32 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 23:33:32 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 23:33:32 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 23:33:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:33:32 INFO - Return code: 0 23:33:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:33:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:33:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:33:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:33:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:33:32 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/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 23:33:32 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/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 23:33:32 INFO - Using env: {'DISPLAY': ':0', 23:33:32 INFO - 'HOME': '/home/cltbld', 23:33:32 INFO - 'LANG': 'en_US.UTF-8', 23:33:32 INFO - 'LANGUAGE': 'en_US:en', 23:33:32 INFO - 'LOGNAME': 'cltbld', 23:33:32 INFO - 'MAIL': '/var/mail/cltbld', 23:33:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:33:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:32 INFO - 'MOZ_NO_REMOTE': '1', 23:33:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:32 INFO - 'NO_EM_RESTART': '1', 23:33:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:32 INFO - 'PWD': '/builds/slave/test', 23:33:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:33:32 INFO - 'SHELL': '/bin/bash', 23:33:32 INFO - 'SHLVL': '1', 23:33:32 INFO - 'TERM': 'linux', 23:33:32 INFO - 'TMOUT': '86400', 23:33:32 INFO - 'USER': 'cltbld', 23:33:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349', 23:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:32 INFO - '_': '/tools/buildbot/bin/python'} 23:33:32 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/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 23:33:32 INFO - mozversion application_buildid: 20170109215908 23:33:32 INFO - mozversion application_changeset: 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 23:33:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:33:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:33:32 INFO - mozversion application_name: Firefox 23:33:32 INFO - mozversion application_remotingname: firefox-dev 23:33:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:33:32 INFO - mozversion application_vendor: Mozilla 23:33:32 INFO - mozversion application_version: 52.0a2 23:33:32 INFO - mozversion platform_buildid: 20170109215908 23:33:32 INFO - mozversion platform_changeset: 091c74eb5714ac9e211e76c8809e4c3e2b8b98b2 23:33:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:33:32 INFO - mozversion platform_version: 52.0a2 23:33:32 INFO - using testdate: 1484033612 23:33:32 INFO - actual date: 1484033612 23:33:32 INFO - starting webserver on 'localhost:47939' 23:33:32 INFO - SUITE-START | Running 2 tests 23:33:32 INFO - TEST-START | dromaeo_css 23:33:32 INFO - operating with platform_type : linux_ 23:33:32 INFO - Initialising browser for dromaeo_css test... 23:33:32 INFO - TEST-INFO | started process 4798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwowvzW/profile http://localhost:47939/getInfo.html) 23:33:35 INFO - PROCESS | 4798 | __metrics Screen width/height:1600/1200 23:33:35 INFO - PROCESS | 4798 | colorDepth:24 23:33:35 INFO - PROCESS | 4798 | Browser inner width/height: 1024/697 23:33:35 INFO - PROCESS | 4798 | __metrics 23:33:36 INFO - PROCESS | 4798 | 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" 23:33:36 INFO - PROCESS | 4798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:33:36 INFO - PROCESS | 4798 | console.error: PushService: 23:33:36 INFO - PROCESS | 4798 | stateChangeProcessEnqueue: Error transitioning state 23:33:36 INFO - PROCESS | 4798 | UnknownError 23:33:37 INFO - TEST-INFO | 4798: exit 0 23:33:37 INFO - Browser initialized. 23:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 23:33:37 INFO - TEST-INFO | started process 4891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwowvzW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:49 INFO - PROCESS | 4891 | RSS: Main: 144437248 23:33:49 INFO - PROCESS | 4891 | 23:36:51 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47939/tests/dromaeo/cssquery-ext.html) 23:36:52 INFO - PROCESS | 4891 | RSS: Main: 243818496 23:36:52 INFO - PROCESS | 4891 | 23:39:54 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-ext.html (next: http://localhost:47939/tests/dromaeo/cssquery-jquery.html) 23:39:55 INFO - PROCESS | 4891 | RSS: Main: 233316352 23:39:55 INFO - PROCESS | 4891 | 23:42:57 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47939/tests/dromaeo/cssquery-mootools.html) 23:42:58 INFO - PROCESS | 4891 | RSS: Main: 225697792 23:42:58 INFO - PROCESS | 4891 | 23:46:00 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47939/tests/dromaeo/cssquery-prototype.html) 23:46:00 INFO - PROCESS | 4891 | RSS: Main: 216522752 23:46:00 INFO - PROCESS | 4891 | 23:49:03 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47939/tests/dromaeo/cssquery-yui.html) 23:49:04 INFO - PROCESS | 4891 | RSS: Main: 174395392 23:49:04 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-yui.html (next: http://localhost:47939/tests/dromaeo/cssquery-dojo.html) 23:52:06 INFO - PROCESS | 4891 | RSS: Main: 260292608 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | __start_tp_report 23:52:06 INFO - PROCESS | 4891 | _x_x_mozilla_page_load 23:52:06 INFO - PROCESS | 4891 | _x_x_mozilla_page_load_details 23:52:06 INFO - PROCESS | 4891 | |i|pagename|runs| 23:52:06 INFO - PROCESS | 4891 | |0;dojo.html;3245.1887028242954;3255.6907093826085;3259.1852036990754;3277.5739153909994;3326.4677651575753;5544.500994910457;5705.400932902043;5727.2268243787075;5737.397573254811;5745.310562732468;5714.457126572979;5761.107028410593;5761.711914404284;5769.971150144253;5777.624454410471;5210.791568337271;5218.817341393052;5230.163173892178;5251.501107394792;5297.284866543026;5095.210242412432;5310.62825602208;5311.097113490716;5323.281357016811;5349.786008559653;5064.797408103672;5097.541221290083;5109.69341839489;5130.307408499861;5155.974220128895;5205.739713014353;5212.869678258055;5283.577313814885;5292.126799078147;5313.229581710669;5031.522005409517;5132.28148059272;5195.376554813409;5234.398044224925;5249.580033597341;5438.809641662523;5440.619156659035;5538.224648549206;5566.832995010156;5598.24423702799;5865.178874957509;5948.37542058082;5968.7910923117915;5979.312379076418;5987.461128498456;5927.051671732502;5997.950358687256;6009.819705408845;6019.277686677583;6023.674791545853;5528.419515950807;5582.134769110794;5591.832245032656;5593.161025846074;5605.103183490622;6110.908336374958;6120.846978825565;6126.816195514141;6128.938710612926;6132.78535251273;5793.073108302651;5855.941440585625;5867.354590994987;5880.353161152269;5880.411958804086;5890.352061273256;5955.940440595538;6011.068284415923;6013.458788709037;6101.023836186189;6056.788012419544;6058.363871793486;6065.969670151621;6085.9958106912745;6101.816945491642;6024.246969128859;6066.48434883031;6075.301340345828;6076.574639775174;6090.025595904723;4584.587387135174;4620;4669.276262179367;4680.087382960358;4707.129181101439;4192.413062171298;4199.328107502785;4211.389348544444;4244.787760611957;4247.129338485603;5878.118282257696;5878.853028674317;5879.353271140171;5886.381929897385;5886.764529418861;5906.173135760997;5963.9105413417965;6019.969900150471;6184.6598437085495;6189.04069869171;5739.426057394311;5815.040518314515;5815.854603634943;5834.504067154339;5841.707914604252;5292.073887069748;5294.788208471618;5298.92051619226;5300;5302.973485132549;6234.875302493834;6267.874642507124;6301.684915754102;6391.265004524446;6393;6055.333913269625;6094.9085763714465;6110.908336375047;6149;6149.907751383822;6383.042543618309;6399.680015999088;6408.807735767934;6409.134766806608;6413.16628838248;5796.159556864147;6016.368281330398;6027.909581356371;6033.3061697905305;6035.36628653985;6015.308239552507;6042.274927008787;6082.11809287642;6090.116933044772;6134.754609815736;5988.401159884151;5993.640381577119;5994.28068631767;5996.040633498619;6002.069679199731;5973.581849270683;5976;5983.670898100646;5985.521158307412;5986.2217911671205;5632.88734225305;5727.026405511157;5756.2229099072765;5786.132080188006;5786.884262314814;5932.49573786233;5941.792037278675;5942.1978032965;5946.048632218824;5953.523718102628;5691.7438715257085;5726.513246374105;5783;5783.826485205451;5790.681512516683 23:52:06 INFO - PROCESS | 4891 | |1;ext.html;580.3181262017132;614.1064750787604;647.1134545672427;656.1076935367898;661.9635920024397;35611.2877742445;42932.3560146598;43950.560494395046;43979.3403098953;47058.76470617651;45149;45582.54417455824;45672.77163614177;45686.314705279445;45698;8375.497470151811;8784.1655042771;8932.821343573125;8935.151160639729;8938.1508756668;8364.45631033984;10543.261971661987;10791.676249712522;10792.352458852454;11126;10817.242793004454;10858.23992320538;10907;10917.836232456519;10920.50857711405;10757;10781.838272425919;10807.297525660806;10812.135029197645;10846.078083362923;10694.839577406345;10760.461976901124;10770.838437423445;10778.137748980063;10786.137109031259;42163.7891810539;42493;42579.36130958038;42594.78702606498;42685;3597.1007248187952;3621.311950729353;3630.673239408466;3747.9250414991548;3808.314503389389;31983.52024719631;32586.511202331985;32934.34131317384;33048.834755826065;33639.6636033639;4427.977860110679;4470.731756094645;4478.2386994211065;4508.842190523349;4577.885552861172;359707;360394;360997;362146;362299;60138.097928531104;60328.698356507935;60430.697846511364;60665.393346065975;60702;39265;39835.40246896299;40018.799906000284;42214.788926055175;42251.15497690029;16890.324387024626;17125.48623541296;17132.486025419257;17146.142692865305;17149.142542872807;11136.498857551429;11378;11913.70215744596;12720.427580758887;12960.027997900195;18994.14526346318;19734.60530789405;19803.40589782309;19807.702884456743;19822.20711171537;7308.933639950668;7342.412606991535;7364.189939106694;7687.6156192190165;7781.649825757854;904.2449554621965;1013.7769690668041;1014.1633152649094;1031.5615863258085;1053.8577292065627;33918.66081339155;34029.82985085059;34337;34444.311113777585;34612;1037.4190453346;1114.2200459678095;1156.259993604094;1158.4265788434611;1236.5269461077844;14807.333669984877;17472.563185920455;17874.55313617144;18112.547186320448;18113.728294075336;540450;542264;542373;543147;544533;59842.70078649666;60651.09023364653;60689;60701.69649151726;60730.69634651887;1271.5867343113525;1274.6813296675832;1313.2448841915746;1360.143109840794;1395.5185461015933;32629.836850815595;35038.29923401467;35197;35250;35487.46768798522;51192.74403628107;51644.22533662073;51730;51770.48229517657;51799.74100129626;377629;380823;382561;383447;385038;29662.110136695934;30508.542371863994;31904;32024.839875800473;32272.515912260864;49406;49434;49526.75236623794;50084;50273.24590131224;39955.40066898941;40448.19103617852;41107;42146.15707685768;42244;42897.142057159304;42986.88093643777;43227.41600561615;43512;43769;43027.78486107675;43888.90277743082;43964.56035439733;44228.33657495076;44349.55650443454;34979.650203498655;35895.820520898276;37451.250974979805;37880.62119378771;37900.62099378971;28628.427431450837;28974.27564310909;29061;29296.707032929397;29309.26726831761 23:52:06 INFO - PROCESS | 4891 | |2;jquery.html;385.48730188848833;404.44792857749184;405.7220803749432;411.7776400743598;421.80596925414306;14223.21772302523;16164.515064548068;19724.408267751973;20104.798952010475;20231.59536809263;19625.901870490627;19811.603767924633;19892.104855281512;20145.39563813084;20277;4713.858584242461;5622.662640241578;5807.361190269067;5849.8830023399505;5859.619124756899;4297;4476.418065651461;5723.227364305807;5822.3886491918165;6175.258968923736;6434.324395938406;6539.542232043759;6541.051547525606;6555.737770489175;6557.3442655734525;6300.8739825203465;6485.935140648604;6504.252011018746;6510.9023364649565;6517.478601711875;5586.190002449663;5732.8853422931725;5795.855103622401;5803.883922321572;5806.767729290866;23863.284101476984;23869.403264918517;24041.158559450334;24071.518569628508;24280.757192428027;2509.723930367658;2903.9709602903913;2958.7189217024566;3144.0882144178163;3187.9681203188134;14449.855501444956;14683.706325873423;14743.410263589443;14775.630609234855;15134.621634459116;1977.5649357141406;1984.5832375201226;1993.4717299915535;2041.5712700332947;2070.223666125203;86089.56955215184;87188.5640571793;87304.56347718285;88188;89134;10400;10552.419616921143;10569.577216911392;10689.465526723632;10826.56693732242;14256.786148207786;14272.500462483764;14304;14462.349194286282;14760.040597361138;7967.322777563856;8083.636236369378;8170.7957301067945;8344.707935222237;8402.873956890651;8013.238742319587;8056.637451314705;8074.677012919417;8198.713045043394;8243.917560824435;6565.409113179741;6619.602823830585;6670.39966403026;6676.232233293136;6878.174619045746;1784.8839825411308;1787.204693911197;1834.6798264814709;1850.5928695686928;1945.1733013469218;898.2679116520146;909.7498187998353;1010.9191264698807;1044.7649278912183;1136.2443974756695;19696.70454943177;19810.40568782939;20265.392038238875;20650.690239646116;20910.581788364147;1025.6307729217476;1041.3699711674478;1042.1870940666292;1074.6561100447939;1094.0536435982817;10913.618023369145;11851.762964740828;11944.940275298743;11999;12000.399980000964;470086;471792;479994;482676;508036;78187;81329;82155;83753.58123209345;85143.14856851353;954.165105532645;1042.155853758458;1098.4233277529202;1110.777844431101;1134.0304040045808;14399.496017639332;18625.254989800796;18787.71818422752;18850.434486965412;18876.24495020184;41366.58633413627;41519.58480415157;42023.36964945467;42442.15115697731;42529.14941701087;53754.19368709551;53876.46123538714;54110.72944635252;55198;56201.718991404785;8599.226069653761;8675.305975521816;8727.694530691395;8961.283097352327;9070.81858362816;13328.86671133315;13481.730365392441;13562.728745424838;13592.45630174782;13790.172589644251;11851.229670071418;12071.094667899766;12145.69635759113;12251.38743062861;12274.14081014356;10466.68599942003;10653.094486968694;10836.67489975302;10844.566217351217;10878.782424351626;11601.767964640829;11727.648170554898;12351.567695130627;12423.31671758062;12423.31671758062;8585.484870907765;8650.1782330681;8710.825783484168;8761.080086591071;8905.376623636283;8249.092599813896;8281.503109813431;8455.830883382176;8490.61792219364;8837.734867953972 23:52:06 INFO - PROCESS | 4891 | |3;mootools.html;1490.0165890512264;1514.4623658601197;1624.943126990555;1763.0920076160771;1806.3497141029236;8242;8789.560521973908;8807.91192088079;8809.207171354577;8841.204291613754;7719.807004824882;7929.207079292068;7939.722109726161;8126.10612832588;8531.78670533237;2236.049678886475;2421.32202983165;2492.015653816741;2497.837640553358;2529.051605647882;2469.074097213536;2513.9120130795336;2521.848689078652;2522.936926576841;2524.0787112703824;2390.4740956989435;2408.7109546854313;2424.8423852449623;2426.4904370082218;2429.5869702150676;2412.9155479558217;2434.732179460258;2436.5492383908945;2436.84160529565;2437.9878100609562;2413.505231427553;2480.3179125740385;2481.4292712676006;2481.5161043596504;2483.0688491815567;8593.613287402082;8791.340649451316;8794.34042446819;8802.559872006374;8817.250533704642;5464.398916119224;5611.382747897769;5621.100623900156;5622.775088996435;5628.746706398181;3281.556989806393;3377.7804442711144;3399.9320013599836;3522.964770352315;3525.761141675029;1103.2497901427028;1112.249231768561;1120.3278033180109;1124.3591153042769;1144.874063852984;11975.46110425033;11987.280763154238;11998.760024799456;12011.699707507381;12039.759204815855;4821.252705830602;4942.728149951788;4991.226359914219;4999.175136102503;5054.646174767805;9875.654352097787;9906.702798916043;9908.752281192883;9911.900880991241;9924.454155021398;5519.779208831602;5547;5551.417101204396;5555.055640541118;5555.472230138131;4599.33309670096;5000.524950129732;5093.439721630618;5097.8725531861255;5123.026624941249;3940.408938659167;4102.91794164121;4195.811188496525;4292;4326.762028088422;1382.5092092307286;1405.641561401836;1413.8727514523741;1421.374595178139;1427.4932398998415;932.1983094538691;932.7341707613298;941.0636416765362;950.3816984208462;953.2135987809946;5268.560039860488;5278;5303.071962406563;5423.810166644149;5440.047991601454;835.6699103854065;887.5739644970321;920.3833431600843;929.1730359979623;934.9439033657866;3870.5935876732538;3887.319719049155;3899.1421887184774;3903.1998440320235;3904.707146963989;10152.949235253776;10449.216308776871;10474.947625261977;10503.94748026255;10506.527206275736;10416.427096509613;10422.166226701846;10443.94778026105;10483.056524912794;10483.737906552396;7897.565633890076;8030.678772849137;8110.499557581867;8117.431779775359;8140.185981401813;5344.848171289916;5367.651102678469;5519.834404967857;5564;5589.441055894541;9599.952000239955;9696.369735967139;9777.217822574035;9785.510724463891;9792.706218813448;9661.951690241503;9749.610015599297;9819.950900245452;9822.803543929223;9881.160101391462;6744.932550674626;7193.892091618734;7280.089988751406;7318.231585683427;7349.448791340564;7796.337311328601;7923.484973476936;8220.506769593843;8225.753227403187;8444.451110677786;7397.889031664422;7428.591427471541;7574.886376704464;7638.579878106535;7722.498037627761;7264.200937896932;7289.489735718661;7421.2949769771785;7444.702211911463;7547.73582924595;6991.755288564876;7103.2541583133025;7112.146542414944;7114.075170227838;7146.821329466805;4968.602511799119;4985.4266759323145;5001.524855138756;5069.797208111634;5149.871253218699;5068.467810879952;5130.076586214517;5217.895642087061;5253.185756207794;5362.570994320367 23:52:06 INFO - PROCESS | 4891 | |4;prototype.html;333.9030100664842;340.4824666506909;343.5585272924292;348.7663265612038;353.05205523170304;5141.640085194038;5261.657992230507;5271.551918086958;5327.961047595715;5343.408446903254;5131.692098474095;5250.3699556053325;5251.632385732991;5262.657927234727;5271.762770675319;4193.972476743203;4200.70595058346;4201.369794530814;4203.831846726127;4215.241256573816;4078.6125318094882;4164.167166566684;4202.243596152692;4209.726367786099;4223.986243301616;4126.401671757593;4138.213739389522;4149.232392007473;4150.481189851269;4159.708820382574;4123.257813593552;4130.5043394792665;4136.490181083883;4147.336426171798;4162.4796900387455;3596.1728802375337;3691.6862066724093;3708.5894168790232;3719.3491139050557;3729.664330210294;5171.534561889448;5172.8965420691375;5192.506711862367;5196.168613021899;5199.428062913076;4766.332713420124;4771.5467030632035;4776.068666610013;4779.569838714532;4792.688475249098;5370.516653501204;5530.391656917735;5537;5560.610757246995;5561.304836895388;4050.4126901599398;4051.6353528182312;4060.47213862199;4064;4065.7560546367017;5692.487676109128;5702.54379649627;5742.454466825645;5750.792333609947;5758.3665796762325;3893.902652433655;4077.347624380085;4079.6940229482907;4091.447654566655;4139.79301034947;4122.34042553196;4131.29767939451;4135.91728165435;4138.606832350922;4142.751434913915;4711.411073615798;4715.386999690087;4723.031778485471;4729.527047295312;4731.29030645406;5379.919301210485;5512.779488820483;5599.8600034998635;5601.131824567198;5601.163203205817;1324.6158614001831;1347.198416941918;1403.4105675616265;1425.6435891027243;1433.5985923941314;1001.2540657210425;1023.2070145637042;1037.1443559063803;1037.4501514197486;1038.8805287391895;5200.829813291979;5204.453532379046;5215.687058776485;5216.321878155815;5225.973870130625;5386.730663466811;5417.322834645669;5426.457354264542;5430.70131142791;5484.314460692413;5227.523696741624;5244.695841619831;5265.4730128263145;5267.947320526822;5409.540189083893;2927.4730548501475;2956.408718256357;2963.3332500187284;2963.6739958604535;2970.8461365510266;5695.686737229492;5740.684262365527;5771.769129234867;5807.141714651356;5818.894410062075;5543.754779314384;5681.943180568224;5699.857503562361;5722.828315150552;5724.62428092337;5852.756751355319;5853.678047707417;5861.743228856921;5868.09044598088;5882.088411206585;5371.811986580451;5600.69196194197;5622;5630.774769009194;5638.23883775685;5553.389127195925;5566.022178134678;5571.331440227036;5574.275344205227;5579.079451890392;5841.386654401396;5842.795502157404;5845.41545845412;5851.531877449879;5879.559507920587;3881.4954055972544;4046.9595304046584;4054.432379466936;4064.532578753481;4079.5920407958965;5516.365617953827;5543.778248870161;5559.221708960829;5612.663240205601;5621.269234999424;5489.835304940858;5564.4991950724625;5566.777328906798;5603.439656034364;5612.186232996111;5602;5616.297962754656;5618.634788738719;5621.044422448112;5661.179129026351;5365.490278423544;5557.41647127062;5587.664740115606;5601.871288910188;5613.971930140323;5600.439956004367;5624.943750562442;5666.34836993751;5674.659520428788;5675.602707810579;5285.392179899361;5544.7543744783425;5548.667079975215;5582.665040097607;5589.944100559105 23:52:06 INFO - PROCESS | 4891 | |5;yui.html;792.4017366887998;820.5240960243055;827.2141465607673;852.1521086518915;881.1496905486207;14947.252637368128;15702.607434814136;15753.133577653252;15793.526194214162;15832.445864394735;14803.555893323217;14923.92538037311;14954;14977.251137443112;14988;698.5948150072945;719.4460265595488;828.8383765165795;833.4957350802767;850.7235148576707;860.3160487412522;862.9482231066156;863.1109956744563;863.3611127765471;865.1867244789909;905.678484138128;909.2998391238742;910.1490106750176;910.2081189365261;910.4628269321099;745.9738909138181;770.3606007014165;866.8743032260319;884.4162852517308;897.1297841094129;653.0432915778407;658.5883822610868;659.5218466611668;659.5515049766157;660.3759447322283;14633.487827925972;14847.406103755837;14849.554513364616;14861.108333500024;14910.403583856632;13598.512974101614;14031.579052628438;14289.71420571593;14400.135991840523;14453.710925781426;12199.695007624792;12363.320017399039;12453.1905426147;12498.500059997588;12592.74814503714;3811.5616704079107;4408;4441.311596702516;4507.143642707908;4556.088782243532;63157.68421157865;69083.30916690819;70459;70479;70714.29285707128;10785.676429707122;11057.723556911142;11220;11264;11700.06399488039;19749.703754443693;19821.40535783929;19851;19995.800041999686;20009.899950500447;7872.209422419907;8055.718049868344;8184.959075204586;8223.465474744122;8242.793930151674;4764.666473346832;4895.975520122377;4925.16272233714;5022.6233032522705;5089.389273287155;3520.0847779577493;3676.246369494247;3678.301122786662;3678.9632103679155;3684.3920753075977;588.6056342250703;606.7360698096343;609.856683679335;611.9663418511935;612.592625903769;604.0998911621652;611.4955161991375;673.7338751193251;685.2017399729259;706.5584009993754;8889.955550222208;8943.284537237005;8965.551722413853;9063.637454501877;9616;509;524.8058218459119;533.7696609315487;564.4412032088203;578;4397.912041759147;4530.728156310632;4631.884202894955;4713.481517033124;5020.422651395063;84352;87061.5646921774;88539.55730221437;89772;90961.54519227493;49585.50414495809;50358.49641503611;51901.22148167781;53538.732306339;73121.26878731251;74044.25955740482;74204.25795742082;76178.23821761823;76676;78103;9067.116001056898;9668.589548629714;9682.46746428925;9721.659741909;9745.366551174151;48828.26757598568;49076;49562;49655;50095.49904501054;39540.40689389604;54155.72922135364;54240.45759542354;59206;65965.67017164883;11870.525178992744;12128.878711212776;12426.937865310616;12547.43536540876;12691.175073620185;14156.858431415554;14287.357068932131;14475.420983160555;14529;14565.781513277521;10400.375977441076;13095.934520327337;13355.933220333836;13436.93281533586;14407.927960360132;12999.740005199654;13547.729045418839;13604.115732477358;13660.931695341857;13714.588562343146;12594.24434533931;12600.621981340575;12852.293123878277;12946.482140714266;13222.735545289233;10551.630692925712;11133.83299250528;11192.328460292409;11214.831777523506;11282.097432205568;11447;11530.250533715282;11532.481038353462;11671.066314694974;11715.472803724024 23:52:06 INFO - PROCESS | 4891 | __end_tp_report 23:52:06 INFO - PROCESS | 4891 | __start_cc_report 23:52:06 INFO - PROCESS | 4891 | _x_x_mozilla_cycle_collect,1005 23:52:06 INFO - PROCESS | 4891 | __end_cc_report 23:52:06 INFO - PROCESS | 4891 | __startTimestamp1484034726759__endTimestamp 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | ------- Summary: start ------- 23:52:06 INFO - PROCESS | 4891 | Number of tests: 6 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#0] dojo.html Cycles:165 Average:5640.96 Median:5855.94 stddev:628.23 (10.7%) stddev-sans-first:601.38 23:52:06 INFO - PROCESS | 4891 | Values: 3245.2 3255.7 3259.2 3277.6 3326.5 5544.5 5705.4 5727.2 5737.4 5745.3 5714.5 5761.1 5761.7 5770.0 5777.6 5210.8 5218.8 5230.2 5251.5 5297.3 5095.2 5310.6 5311.1 5323.3 5349.8 5064.8 5097.5 5109.7 5130.3 5156.0 5205.7 5212.9 5283.6 5292.1 5313.2 5031.5 5132.3 5195.4 5234.4 5249.6 5438.8 5440.6 5538.2 5566.8 5598.2 5865.2 5948.4 5968.8 5979.3 5987.5 5927.1 5998.0 6009.8 6019.3 6023.7 5528.4 5582.1 5591.8 5593.2 5605.1 6110.9 6120.8 6126.8 6128.9 6132.8 5793.1 5855.9 5867.4 5880.4 5880.4 5890.4 5955.9 6011.1 6013.5 6101.0 6056.8 6058.4 6066.0 6086.0 6101.8 6024.2 6066.5 6075.3 6076.6 6090.0 4584.6 4620.0 4669.3 4680.1 4707.1 4192.4 4199.3 4211.4 4244.8 4247.1 5878.1 5878.9 5879.4 5886.4 5886.8 5906.2 5963.9 6020.0 6184.7 6189.0 5739.4 5815.0 5815.9 5834.5 5841.7 5292.1 5294.8 5298.9 5300.0 5303.0 6234.9 6267.9 6301.7 6391.3 6393.0 6055.3 6094.9 6110.9 6149.0 6149.9 6383.0 6399.7 6408.8 6409.1 6413.2 5796.2 6016.4 6027.9 6033.3 6035.4 6015.3 6042.3 6082.1 6090.1 6134.8 5988.4 5993.6 5994.3 5996.0 6002.1 5973.6 5976.0 5983.7 5985.5 5986.2 5632.9 5727.0 5756.2 5786.1 5786.9 5932.5 5941.8 5942.2 5946.0 5953.5 5691.7 5726.5 5783.0 5783.8 5790.7 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#1] ext.html Cycles:180 Average:59557.52 Median:190688.46 stddev:115387.61 (60.5%) stddev-sans-first:115626.33 23:52:06 INFO - PROCESS | 4891 | Values: 580.3 614.1 647.1 656.1 662.0 35611.3 42932.4 43950.6 43979.3 47058.8 45149.0 45582.5 45672.8 45686.3 45698.0 8375.5 8784.2 8932.8 8935.2 8938.2 8364.5 10543.3 10791.7 10792.4 11126.0 10817.2 10858.2 10907.0 10917.8 10920.5 10757.0 10781.8 10807.3 10812.1 10846.1 10694.8 10760.5 10770.8 10778.1 10786.1 42163.8 42493.0 42579.4 42594.8 42685.0 3597.1 3621.3 3630.7 3747.9 3808.3 31983.5 32586.5 32934.3 33048.8 33639.7 4428.0 4470.7 4478.2 4508.8 4577.9 359707.0 360394.0 360997.0 362146.0 362299.0 60138.1 60328.7 60430.7 60665.4 60702.0 39265.0 39835.4 40018.8 42214.8 42251.2 16890.3 17125.5 17132.5 17146.1 17149.1 11136.5 11378.0 11913.7 12720.4 12960.0 18994.1 19734.6 19803.4 19807.7 19822.2 7308.9 7342.4 7364.2 7687.6 7781.6 904.2 1013.8 1014.2 1031.6 1053.9 33918.7 34029.8 34337.0 34444.3 34612.0 1037.4 1114.2 1156.3 1158.4 1236.5 14807.3 17472.6 17874.6 18112.5 18113.7 540450.0 542264.0 542373.0 543147.0 544533.0 59842.7 60651.1 60689.0 60701.7 60730.7 1271.6 1274.7 1313.2 1360.1 1395.5 32629.8 35038.3 35197.0 35250.0 35487.5 51192.7 51644.2 51730.0 51770.5 51799.7 377629.0 380823.0 382561.0 383447.0 385038.0 29662.1 30508.5 31904.0 32024.8 32272.5 49406.0 49434.0 49526.8 50084.0 50273.2 39955.4 40448.2 41107.0 42146.2 42244.0 42897.1 42986.9 43227.4 43512.0 43769.0 43027.8 43888.9 43964.6 44228.3 44349.6 34979.7 35895.8 37451.3 37880.6 37900.6 28628.4 28974.3 29061.0 29296.7 29309.3 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#2] jquery.html Cycles:180 Average:28833.31 Median:3166.03 stddev:79481.18 (2510.4%) stddev-sans-first:79675.44 23:52:06 INFO - PROCESS | 4891 | Values: 385.5 404.4 405.7 411.8 421.8 14223.2 16164.5 19724.4 20104.8 20231.6 19625.9 19811.6 19892.1 20145.4 20277.0 4713.9 5622.7 5807.4 5849.9 5859.6 4297.0 4476.4 5723.2 5822.4 6175.3 6434.3 6539.5 6541.1 6555.7 6557.3 6300.9 6485.9 6504.3 6510.9 6517.5 5586.2 5732.9 5795.9 5803.9 5806.8 23863.3 23869.4 24041.2 24071.5 24280.8 2509.7 2904.0 2958.7 3144.1 3188.0 14449.9 14683.7 14743.4 14775.6 15134.6 1977.6 1984.6 1993.5 2041.6 2070.2 86089.6 87188.6 87304.6 88188.0 89134.0 10400.0 10552.4 10569.6 10689.5 10826.6 14256.8 14272.5 14304.0 14462.3 14760.0 7967.3 8083.6 8170.8 8344.7 8402.9 8013.2 8056.6 8074.7 8198.7 8243.9 6565.4 6619.6 6670.4 6676.2 6878.2 1784.9 1787.2 1834.7 1850.6 1945.2 898.3 909.7 1010.9 1044.8 1136.2 19696.7 19810.4 20265.4 20650.7 20910.6 1025.6 1041.4 1042.2 1074.7 1094.1 10913.6 11851.8 11944.9 11999.0 12000.4 470086.0 471792.0 479994.0 482676.0 508036.0 78187.0 81329.0 82155.0 83753.6 85143.1 954.2 1042.2 1098.4 1110.8 1134.0 14399.5 18625.3 18787.7 18850.4 18876.2 41366.6 41519.6 42023.4 42442.2 42529.1 53754.2 53876.5 54110.7 55198.0 56201.7 8599.2 8675.3 8727.7 8961.3 9070.8 13328.9 13481.7 13562.7 13592.5 13790.2 11851.2 12071.1 12145.7 12251.4 12274.1 10466.7 10653.1 10836.7 10844.6 10878.8 11601.8 11727.6 12351.6 12423.3 12423.3 8585.5 8650.2 8710.8 8761.1 8905.4 8249.1 8281.5 8455.8 8490.6 8837.7 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#3] mootools.html Cycles:180 Average:5697.27 Median:5290.54 stddev:3119.40 (59.0%) stddev-sans-first:3112.12 23:52:06 INFO - PROCESS | 4891 | Values: 1490.0 1514.5 1624.9 1763.1 1806.3 8242.0 8789.6 8807.9 8809.2 8841.2 7719.8 7929.2 7939.7 8126.1 8531.8 2236.0 2421.3 2492.0 2497.8 2529.1 2469.1 2513.9 2521.8 2522.9 2524.1 2390.5 2408.7 2424.8 2426.5 2429.6 2412.9 2434.7 2436.5 2436.8 2438.0 2413.5 2480.3 2481.4 2481.5 2483.1 8593.6 8791.3 8794.3 8802.6 8817.3 5464.4 5611.4 5621.1 5622.8 5628.7 3281.6 3377.8 3399.9 3523.0 3525.8 1103.2 1112.2 1120.3 1124.4 1144.9 11975.5 11987.3 11998.8 12011.7 12039.8 4821.3 4942.7 4991.2 4999.2 5054.6 9875.7 9906.7 9908.8 9911.9 9924.5 5519.8 5547.0 5551.4 5555.1 5555.5 4599.3 5000.5 5093.4 5097.9 5123.0 3940.4 4102.9 4195.8 4292.0 4326.8 1382.5 1405.6 1413.9 1421.4 1427.5 932.2 932.7 941.1 950.4 953.2 5268.6 5278.0 5303.1 5423.8 5440.0 835.7 887.6 920.4 929.2 934.9 3870.6 3887.3 3899.1 3903.2 3904.7 10152.9 10449.2 10474.9 10503.9 10506.5 10416.4 10422.2 10443.9 10483.1 10483.7 7897.6 8030.7 8110.5 8117.4 8140.2 5344.8 5367.7 5519.8 5564.0 5589.4 9600.0 9696.4 9777.2 9785.5 9792.7 9662.0 9749.6 9820.0 9822.8 9881.2 6744.9 7193.9 7280.1 7318.2 7349.4 7796.3 7923.5 8220.5 8225.8 8444.5 7397.9 7428.6 7574.9 7638.6 7722.5 7264.2 7289.5 7421.3 7444.7 7547.7 6991.8 7103.3 7112.1 7114.1 7146.8 4968.6 4985.4 5001.5 5069.8 5149.9 5068.5 5130.1 5217.9 5253.2 5362.6 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#4] prototype.html Cycles:180 Average:4666.68 Median:5256.65 stddev:1353.92 (25.8%) stddev-sans-first:1318.08 23:52:06 INFO - PROCESS | 4891 | Values: 333.9 340.5 343.6 348.8 353.1 5141.6 5261.7 5271.6 5328.0 5343.4 5131.7 5250.4 5251.6 5262.7 5271.8 4194.0 4200.7 4201.4 4203.8 4215.2 4078.6 4164.2 4202.2 4209.7 4224.0 4126.4 4138.2 4149.2 4150.5 4159.7 4123.3 4130.5 4136.5 4147.3 4162.5 3596.2 3691.7 3708.6 3719.3 3729.7 5171.5 5172.9 5192.5 5196.2 5199.4 4766.3 4771.5 4776.1 4779.6 4792.7 5370.5 5530.4 5537.0 5560.6 5561.3 4050.4 4051.6 4060.5 4064.0 4065.8 5692.5 5702.5 5742.5 5750.8 5758.4 3893.9 4077.3 4079.7 4091.4 4139.8 4122.3 4131.3 4135.9 4138.6 4142.8 4711.4 4715.4 4723.0 4729.5 4731.3 5379.9 5512.8 5599.9 5601.1 5601.2 1324.6 1347.2 1403.4 1425.6 1433.6 1001.3 1023.2 1037.1 1037.5 1038.9 5200.8 5204.5 5215.7 5216.3 5226.0 5386.7 5417.3 5426.5 5430.7 5484.3 5227.5 5244.7 5265.5 5267.9 5409.5 2927.5 2956.4 2963.3 2963.7 2970.8 5695.7 5740.7 5771.8 5807.1 5818.9 5543.8 5681.9 5699.9 5722.8 5724.6 5852.8 5853.7 5861.7 5868.1 5882.1 5371.8 5600.7 5622.0 5630.8 5638.2 5553.4 5566.0 5571.3 5574.3 5579.1 5841.4 5842.8 5845.4 5851.5 5879.6 3881.5 4047.0 4054.4 4064.5 4079.6 5516.4 5543.8 5559.2 5612.7 5621.3 5489.8 5564.5 5566.8 5603.4 5612.2 5602.0 5616.3 5618.6 5621.0 5661.2 5365.5 5557.4 5587.7 5601.9 5614.0 5600.4 5624.9 5666.3 5674.7 5675.6 5285.4 5544.8 5548.7 5582.7 5589.9 23:52:06 INFO - PROCESS | 4891 | 23:52:06 INFO - PROCESS | 4891 | [#5] yui.html Cycles:180 Average:17647.00 Median:49573.75 stddev:22890.84 (46.2%) stddev-sans-first:22920.07 23:52:06 INFO - PROCESS | 4891 | Values: 792.4 820.5 827.2 852.2 881.1 14947.3 15702.6 15753.1 15793.5 15832.4 14803.6 14923.9 14954.0 14977.3 14988.0 698.6 719.4 828.8 833.5 850.7 860.3 862.9 863.1 863.4 865.2 905.7 909.3 910.1 910.2 910.5 746.0 770.4 866.9 884.4 897.1 653.0 658.6 659.5 659.6 660.4 14633.5 14847.4 14849.6 14861.1 14910.4 13598.5 14031.6 14289.7 14400.1 14453.7 12199.7 12363.3 12453.2 12498.5 12592.7 3811.6 4408.0 4441.3 4507.1 4556.1 63157.7 69083.3 70459.0 70479.0 70714.3 10785.7 11057.7 11220.0 11264.0 11700.1 19749.7 19821.4 19851.0 19995.8 20009.9 7872.2 8055.7 8185.0 8223.5 8242.8 4764.7 4896.0 4925.2 5022.6 5089.4 3520.1 3676.2 3678.3 3679.0 3684.4 588.6 606.7 609.9 612.0 612.6 604.1 611.5 673.7 685.2 706.6 8890.0 8943.3 8965.6 9063.6 9616.0 509.0 524.8 533.8 564.4 578.0 4397.9 4530.7 4631.9 4713.5 5020.4 84352.0 87061.6 88539.6 89772.0 90961.5 49585.5 50358.5 51901.2 53538.7 73121.3 74044.3 74204.3 76178.2 76676.0 78103.0 9067.1 9668.6 9682.5 9721.7 9745.4 48828.3 49076.0 49562.0 49655.0 50095.5 39540.4 54155.7 54240.5 59206.0 65965.7 11870.5 12128.9 12426.9 12547.4 12691.2 14156.9 14287.4 14475.4 14529.0 14565.8 10400.4 13095.9 13355.9 13436.9 14407.9 12999.7 13547.7 13604.1 13660.9 13714.6 12594.2 12600.6 12852.3 12946.5 13222.7 10551.6 11133.8 11192.3 11214.8 11282.1 11447.0 11530.3 11532.5 11671.1 11715.5 23:52:06 INFO - PROCESS | 4891 | -------- Summary: end -------- 23:52:06 INFO - PROCESS | 4891 | 23:52:07 INFO - TEST-INFO | 4891: exit 0 23:52:07 INFO - TEST-OK | dromaeo_css | took 1115215ms 23:52:07 INFO - TEST-START | kraken 23:52:07 INFO - operating with platform_type : linux_ 23:52:07 INFO - Initialising browser for kraken test... 23:52:07 INFO - TEST-INFO | started process 5217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbdpkJ/profile http://localhost:47939/getInfo.html) 23:52:11 INFO - PROCESS | 5217 | __metrics Screen width/height:1600/1200 23:52:11 INFO - PROCESS | 5217 | colorDepth:24 23:52:11 INFO - PROCESS | 5217 | Browser inner width/height: 1024/697 23:52:11 INFO - PROCESS | 5217 | __metrics 23:52:11 INFO - PROCESS | 5217 | 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" 23:52:11 INFO - PROCESS | 5217 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:11 INFO - PROCESS | 5217 | console.error: PushService: 23:52:11 INFO - PROCESS | 5217 | stateChangeProcessEnqueue: Error transitioning state 23:52:11 INFO - PROCESS | 5217 | UnknownError 23:52:12 INFO - TEST-INFO | 5217: exit 0 23:52:12 INFO - Browser initialized. 23:52:12 INFO - Running cycle 1/1 for kraken test... 23:52:12 INFO - TEST-INFO | started process 5312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbdpkJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:24 INFO - PROCESS | 5312 | RSS: Main: 143425536 23:52:24 INFO - PROCESS | 5312 | 23:52:26 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-beat-detection) 23:52:27 INFO - PROCESS | 5312 | RSS: Main: 185135104 23:52:27 INFO - PROCESS | 5312 | 23:52:30 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-dft) 23:52:30 INFO - PROCESS | 5312 | RSS: Main: 174747648 23:52:30 INFO - PROCESS | 5312 | 23:52:33 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-fft) 23:52:34 INFO - PROCESS | 5312 | RSS: Main: 266125312 23:52:34 INFO - PROCESS | 5312 | 23:52:36 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-oscillator) 23:52:36 INFO - PROCESS | 5312 | RSS: Main: 172957696 23:52:36 INFO - PROCESS | 5312 | 23:52:39 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:52:39 INFO - PROCESS | 5312 | RSS: Main: 175304704 23:52:39 INFO - PROCESS | 5312 | 23:52:42 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-darkroom) 23:52:43 INFO - PROCESS | 5312 | RSS: Main: 213995520 23:52:43 INFO - PROCESS | 5312 | 23:52:46 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-desaturate) 23:52:47 INFO - PROCESS | 5312 | RSS: Main: 212213760 23:52:47 INFO - PROCESS | 5312 | 23:52:49 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47939/tests/kraken/driver.html?testName=json-parse-financial) 23:52:50 INFO - PROCESS | 5312 | RSS: Main: 211038208 23:52:50 INFO - PROCESS | 5312 | 23:52:51 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:52:52 INFO - PROCESS | 5312 | RSS: Main: 173088768 23:52:52 INFO - PROCESS | 5312 | 23:52:54 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:52:54 INFO - PROCESS | 5312 | RSS: Main: 180727808 23:52:54 INFO - PROCESS | 5312 | 23:52:56 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:52:57 INFO - PROCESS | 5312 | RSS: Main: 189693952 23:52:57 INFO - PROCESS | 5312 | 23:52:59 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:53:00 INFO - PROCESS | 5312 | RSS: Main: 198758400 23:53:00 INFO - PROCESS | 5312 | 23:53:03 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:53:03 INFO - PROCESS | 5312 | RSS: Main: 195051520 23:53:03 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47939/tests/kraken/driver.html?testName=ai-astar) 23:53:05 INFO - PROCESS | 5312 | RSS: Main: 247078912 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | __start_tp_report 23:53:05 INFO - PROCESS | 5312 | _x_x_mozilla_page_load 23:53:05 INFO - PROCESS | 5312 | _x_x_mozilla_page_load_details 23:53:05 INFO - PROCESS | 5312 | |i|pagename|runs| 23:53:05 INFO - PROCESS | 5312 | |0;ai-astar;104;110;110;111;111;112;112;112;112;112 23:53:05 INFO - PROCESS | 5312 | |1;audio-beat-detection;141;118;123;162;118;123;120;119;146;126 23:53:05 INFO - PROCESS | 5312 | |2;audio-dft;161;161;162;162;160;161;161;162;162;161 23:53:05 INFO - PROCESS | 5312 | |3;audio-fft;76;76;77;101;75;77;76;77;97;75 23:53:05 INFO - PROCESS | 5312 | |4;audio-oscillator;83;82;128;82;82;83;97;81;83;115 23:53:05 INFO - PROCESS | 5312 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;117 23:53:05 INFO - PROCESS | 5312 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;146 23:53:05 INFO - PROCESS | 5312 | |7;imaging-desaturate;86;85;85;85;84;85;84;84;84;84 23:53:05 INFO - PROCESS | 5312 | |8;json-parse-financial;51;51;50;49;50;50;51;51;50;50 23:53:05 INFO - PROCESS | 5312 | |9;json-stringify-tinderbox;58;59;58;57;77;58;58;59;58;59 23:53:05 INFO - PROCESS | 5312 | |10;stanford-crypto-aes;75;75;74;75;75;75;75;75;75;80 23:53:05 INFO - PROCESS | 5312 | |11;stanford-crypto-ccm;124;127;126;121;122;123;121;120;169;130 23:53:05 INFO - PROCESS | 5312 | |12;stanford-crypto-pbkdf2;158;160;157;154;159;154;154;159;158;155 23:53:05 INFO - PROCESS | 5312 | |13;stanford-crypto-sha256-iterative;64;63;63;63;63;65;62;63;65;60 23:53:05 INFO - PROCESS | 5312 | __end_tp_report 23:53:05 INFO - PROCESS | 5312 | __start_cc_report 23:53:05 INFO - PROCESS | 5312 | _x_x_mozilla_cycle_collect,1634 23:53:05 INFO - PROCESS | 5312 | __end_cc_report 23:53:05 INFO - PROCESS | 5312 | __startTimestamp1484034785716__endTimestamp 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | ------- Summary: start ------- 23:53:05 INFO - PROCESS | 5312 | Number of tests: 14 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:2.46 (2.2%) stddev-sans-first:0.87 23:53:05 INFO - PROCESS | 5312 | Values: 104.0 110.0 110.0 111.0 111.0 112.0 112.0 112.0 112.0 112.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:124.50 stddev:14.99 (12.0%) stddev-sans-first:15.32 23:53:05 INFO - PROCESS | 5312 | Values: 141.0 118.0 123.0 162.0 118.0 123.0 120.0 119.0 146.0 126.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 23:53:05 INFO - PROCESS | 5312 | Values: 161.0 161.0 162.0 162.0 160.0 161.0 161.0 162.0 162.0 161.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.50 stddev:9.72 (12.7%) stddev-sans-first:10.16 23:53:05 INFO - PROCESS | 5312 | Values: 76.0 76.0 77.0 101.0 75.0 77.0 76.0 77.0 97.0 75.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.50 stddev:16.71 (20.3%) stddev-sans-first:17.43 23:53:05 INFO - PROCESS | 5312 | Values: 83.0 82.0 128.0 82.0 82.0 83.0 97.0 81.0 83.0 115.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 23:53:05 INFO - PROCESS | 5312 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:53:05 INFO - PROCESS | 5312 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 23:53:05 INFO - PROCESS | 5312 | Values: 86.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:0.67 (1.3%) stddev-sans-first:0.67 23:53:05 INFO - PROCESS | 5312 | Values: 51.0 51.0 50.0 49.0 50.0 50.0 51.0 51.0 50.0 50.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:58.50 stddev:5.97 (10.2%) stddev-sans-first:6.28 23:53:05 INFO - PROCESS | 5312 | Values: 58.0 59.0 58.0 57.0 77.0 58.0 58.0 59.0 58.0 59.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:1.65 (2.2%) stddev-sans-first:1.74 23:53:05 INFO - PROCESS | 5312 | Values: 75.0 75.0 74.0 75.0 75.0 75.0 75.0 75.0 75.0 80.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:125.00 stddev:14.64 (11.7%) stddev-sans-first:15.44 23:53:05 INFO - PROCESS | 5312 | Values: 124.0 127.0 126.0 121.0 122.0 123.0 121.0 120.0 169.0 130.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:158.00 stddev:2.35 (1.5%) stddev-sans-first:2.45 23:53:05 INFO - PROCESS | 5312 | Values: 158.0 160.0 157.0 154.0 159.0 154.0 154.0 159.0 158.0 155.0 23:53:05 INFO - PROCESS | 5312 | 23:53:05 INFO - PROCESS | 5312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.50 23:53:05 INFO - PROCESS | 5312 | Values: 64.0 63.0 63.0 63.0 63.0 65.0 62.0 63.0 65.0 60.0 23:53:05 INFO - PROCESS | 5312 | -------- Summary: end -------- 23:53:05 INFO - PROCESS | 5312 | 23:53:06 INFO - TEST-INFO | 5312: exit 0 23:53:06 INFO - TEST-OK | kraken | took 59191ms 23:53:06 INFO - SUITE-END | took 1174s 23:53:06 INFO - Completed test suite (00:19:34) 23:53:06 INFO - javascript benchmark 23:53:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.1887028242954, 3255.6907093826085, 3259.1852036990754, 3277.5739153909994, 3326.4677651575753, 5544.500994910457, 5705.400932902043, 5727.2268243787075, 5737.397573254811, 5745.310562732468, 5714.457126572979, 5761.107028410593, 5761.711914404284, 5769.971150144253, 5777.624454410471, 5210.791568337271, 5218.817341393052, 5230.163173892178, 5251.501107394792, 5297.284866543026, 5095.210242412432, 5310.62825602208, 5311.097113490716, 5323.281357016811, 5349.786008559653, 5064.797408103672, 5097.541221290083, 5109.69341839489, 5130.307408499861, 5155.974220128895, 5205.739713014353, 5212.869678258055, 5283.577313814885, 5292.126799078147, 5313.229581710669, 5031.522005409517, 5132.28148059272, 5195.376554813409, 5234.398044224925, 5249.580033597341, 5438.809641662523, 5440.619156659035, 5538.224648549206, 5566.832995010156, 5598.24423702799, 5865.178874957509, 5948.37542058082, 5968.7910923117915, 5979.312379076418, 5987.461128498456, 5927.051671732502, 5997.950358687256, 6009.819705408845, 6019.277686677583, 6023.674791545853, 5528.419515950807, 5582.134769110794, 5591.832245032656, 5593.161025846074, 5605.103183490622, 6110.908336374958, 6120.846978825565, 6126.816195514141, 6128.938710612926, 6132.78535251273, 5793.073108302651, 5855.941440585625, 5867.354590994987, 5880.353161152269, 5880.411958804086, 5890.352061273256, 5955.940440595538, 6011.068284415923, 6013.458788709037, 6101.023836186189, 6056.788012419544, 6058.363871793486, 6065.969670151621, 6085.9958106912745, 6101.816945491642, 6024.246969128859, 6066.48434883031, 6075.301340345828, 6076.574639775174, 6090.025595904723, 4584.587387135174, 4620.0, 4669.276262179367, 4680.087382960358, 4707.129181101439, 4192.413062171298, 4199.328107502785, 4211.389348544444, 4244.787760611957, 4247.129338485603, 5878.118282257696, 5878.853028674317, 5879.353271140171, 5886.381929897385, 5886.764529418861, 5906.173135760997, 5963.9105413417965, 6019.969900150471, 6184.6598437085495, 6189.04069869171, 5739.426057394311, 5815.040518314515, 5815.854603634943, 5834.504067154339, 5841.707914604252, 5292.073887069748, 5294.788208471618, 5298.92051619226, 5300.0, 5302.973485132549, 6234.875302493834, 6267.874642507124, 6301.684915754102, 6391.265004524446, 6393.0, 6055.333913269625, 6094.9085763714465, 6110.908336375047, 6149.0, 6149.907751383822, 6383.042543618309, 6399.680015999088, 6408.807735767934, 6409.134766806608, 6413.16628838248, 5796.159556864147, 6016.368281330398, 6027.909581356371, 6033.3061697905305, 6035.36628653985, 6015.308239552507, 6042.274927008787, 6082.11809287642, 6090.116933044772, 6134.754609815736, 5988.401159884151, 5993.640381577119, 5994.28068631767, 5996.040633498619, 6002.069679199731, 5973.581849270683, 5976.0, 5983.670898100646, 5985.521158307412, 5986.2217911671205, 5632.88734225305, 5727.026405511157, 5756.2229099072765, 5786.132080188006, 5786.884262314814, 5932.49573786233, 5941.792037278675, 5942.1978032965, 5946.048632218824, 5953.523718102628, 5691.7438715257085, 5726.513246374105, 5783.0, 5783.826485205451, 5790.681512516683], "value": 5599.162117933926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.3181262017132, 614.1064750787604, 647.1134545672427, 656.1076935367898, 661.9635920024397, 35611.2877742445, 42932.3560146598, 43950.560494395046, 43979.3403098953, 47058.76470617651, 45149.0, 45582.54417455824, 45672.77163614177, 45686.314705279445, 45698.0, 8375.497470151811, 8784.1655042771, 8932.821343573125, 8935.151160639729, 8938.1508756668, 8364.45631033984, 10543.261971661987, 10791.676249712522, 10792.352458852454, 11126.0, 10817.242793004454, 10858.23992320538, 10907.0, 10917.836232456519, 10920.50857711405, 10757.0, 10781.838272425919, 10807.297525660806, 10812.135029197645, 10846.078083362923, 10694.839577406345, 10760.461976901124, 10770.838437423445, 10778.137748980063, 10786.137109031259, 42163.7891810539, 42493.0, 42579.36130958038, 42594.78702606498, 42685.0, 3597.1007248187952, 3621.311950729353, 3630.673239408466, 3747.9250414991548, 3808.314503389389, 31983.52024719631, 32586.511202331985, 32934.34131317384, 33048.834755826065, 33639.6636033639, 4427.977860110679, 4470.731756094645, 4478.2386994211065, 4508.842190523349, 4577.885552861172, 359707.0, 360394.0, 360997.0, 362146.0, 362299.0, 60138.097928531104, 60328.698356507935, 60430.697846511364, 60665.393346065975, 60702.0, 39265.0, 39835.40246896299, 40018.799906000284, 42214.788926055175, 42251.15497690029, 16890.324387024626, 17125.48623541296, 17132.486025419257, 17146.142692865305, 17149.142542872807, 11136.498857551429, 11378.0, 11913.70215744596, 12720.427580758887, 12960.027997900195, 18994.14526346318, 19734.60530789405, 19803.40589782309, 19807.702884456743, 19822.20711171537, 7308.933639950668, 7342.412606991535, 7364.189939106694, 7687.6156192190165, 7781.649825757854, 904.2449554621965, 1013.7769690668041, 1014.1633152649094, 1031.5615863258085, 1053.8577292065627, 33918.66081339155, 34029.82985085059, 34337.0, 34444.311113777585, 34612.0, 1037.4190453346, 1114.2200459678095, 1156.259993604094, 1158.4265788434611, 1236.5269461077844, 14807.333669984877, 17472.563185920455, 17874.55313617144, 18112.547186320448, 18113.728294075336, 540450.0, 542264.0, 542373.0, 543147.0, 544533.0, 59842.70078649666, 60651.09023364653, 60689.0, 60701.69649151726, 60730.69634651887, 1271.5867343113525, 1274.6813296675832, 1313.2448841915746, 1360.143109840794, 1395.5185461015933, 32629.836850815595, 35038.29923401467, 35197.0, 35250.0, 35487.46768798522, 51192.74403628107, 51644.22533662073, 51730.0, 51770.48229517657, 51799.74100129626, 377629.0, 380823.0, 382561.0, 383447.0, 385038.0, 29662.110136695934, 30508.542371863994, 31904.0, 32024.839875800473, 32272.515912260864, 49406.0, 49434.0, 49526.75236623794, 50084.0, 50273.24590131224, 39955.40066898941, 40448.19103617852, 41107.0, 42146.15707685768, 42244.0, 42897.142057159304, 42986.88093643777, 43227.41600561615, 43512.0, 43769.0, 43027.78486107675, 43888.90277743082, 43964.56035439733, 44228.33657495076, 44349.55650443454, 34979.650203498655, 35895.820520898276, 37451.250974979805, 37880.62119378771, 37900.62099378971, 28628.427431450837, 28974.27564310909, 29061.0, 29296.707032929397, 29309.26726831761], "value": 20684.361198654224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.48730188848833, 404.44792857749184, 405.7220803749432, 411.7776400743598, 421.80596925414306, 14223.21772302523, 16164.515064548068, 19724.408267751973, 20104.798952010475, 20231.59536809263, 19625.901870490627, 19811.603767924633, 19892.104855281512, 20145.39563813084, 20277.0, 4713.858584242461, 5622.662640241578, 5807.361190269067, 5849.8830023399505, 5859.619124756899, 4297.0, 4476.418065651461, 5723.227364305807, 5822.3886491918165, 6175.258968923736, 6434.324395938406, 6539.542232043759, 6541.051547525606, 6555.737770489175, 6557.3442655734525, 6300.8739825203465, 6485.935140648604, 6504.252011018746, 6510.9023364649565, 6517.478601711875, 5586.190002449663, 5732.8853422931725, 5795.855103622401, 5803.883922321572, 5806.767729290866, 23863.284101476984, 23869.403264918517, 24041.158559450334, 24071.518569628508, 24280.757192428027, 2509.723930367658, 2903.9709602903913, 2958.7189217024566, 3144.0882144178163, 3187.9681203188134, 14449.855501444956, 14683.706325873423, 14743.410263589443, 14775.630609234855, 15134.621634459116, 1977.5649357141406, 1984.5832375201226, 1993.4717299915535, 2041.5712700332947, 2070.223666125203, 86089.56955215184, 87188.5640571793, 87304.56347718285, 88188.0, 89134.0, 10400.0, 10552.419616921143, 10569.577216911392, 10689.465526723632, 10826.56693732242, 14256.786148207786, 14272.500462483764, 14304.0, 14462.349194286282, 14760.040597361138, 7967.322777563856, 8083.636236369378, 8170.7957301067945, 8344.707935222237, 8402.873956890651, 8013.238742319587, 8056.637451314705, 8074.677012919417, 8198.713045043394, 8243.917560824435, 6565.409113179741, 6619.602823830585, 6670.39966403026, 6676.232233293136, 6878.174619045746, 1784.8839825411308, 1787.204693911197, 1834.6798264814709, 1850.5928695686928, 1945.1733013469218, 898.2679116520146, 909.7498187998353, 1010.9191264698807, 1044.7649278912183, 1136.2443974756695, 19696.70454943177, 19810.40568782939, 20265.392038238875, 20650.690239646116, 20910.581788364147, 1025.6307729217476, 1041.3699711674478, 1042.1870940666292, 1074.6561100447939, 1094.0536435982817, 10913.618023369145, 11851.762964740828, 11944.940275298743, 11999.0, 12000.399980000964, 470086.0, 471792.0, 479994.0, 482676.0, 508036.0, 78187.0, 81329.0, 82155.0, 83753.58123209345, 85143.14856851353, 954.165105532645, 1042.155853758458, 1098.4233277529202, 1110.777844431101, 1134.0304040045808, 14399.496017639332, 18625.254989800796, 18787.71818422752, 18850.434486965412, 18876.24495020184, 41366.58633413627, 41519.58480415157, 42023.36964945467, 42442.15115697731, 42529.14941701087, 53754.19368709551, 53876.46123538714, 54110.72944635252, 55198.0, 56201.718991404785, 8599.226069653761, 8675.305975521816, 8727.694530691395, 8961.283097352327, 9070.81858362816, 13328.86671133315, 13481.730365392441, 13562.728745424838, 13592.45630174782, 13790.172589644251, 11851.229670071418, 12071.094667899766, 12145.69635759113, 12251.38743062861, 12274.14081014356, 10466.68599942003, 10653.094486968694, 10836.67489975302, 10844.566217351217, 10878.782424351626, 11601.767964640829, 11727.648170554898, 12351.567695130627, 12423.31671758062, 12423.31671758062, 8585.484870907765, 8650.1782330681, 8710.825783484168, 8761.080086591071, 8905.376623636283, 8249.092599813896, 8281.503109813431, 8455.830883382176, 8490.61792219364, 8837.734867953972], "value": 9480.785731445118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.0165890512264, 1514.4623658601197, 1624.943126990555, 1763.0920076160771, 1806.3497141029236, 8242.0, 8789.560521973908, 8807.91192088079, 8809.207171354577, 8841.204291613754, 7719.807004824882, 7929.207079292068, 7939.722109726161, 8126.10612832588, 8531.78670533237, 2236.049678886475, 2421.32202983165, 2492.015653816741, 2497.837640553358, 2529.051605647882, 2469.074097213536, 2513.9120130795336, 2521.848689078652, 2522.936926576841, 2524.0787112703824, 2390.4740956989435, 2408.7109546854313, 2424.8423852449623, 2426.4904370082218, 2429.5869702150676, 2412.9155479558217, 2434.732179460258, 2436.5492383908945, 2436.84160529565, 2437.9878100609562, 2413.505231427553, 2480.3179125740385, 2481.4292712676006, 2481.5161043596504, 2483.0688491815567, 8593.613287402082, 8791.340649451316, 8794.34042446819, 8802.559872006374, 8817.250533704642, 5464.398916119224, 5611.382747897769, 5621.100623900156, 5622.775088996435, 5628.746706398181, 3281.556989806393, 3377.7804442711144, 3399.9320013599836, 3522.964770352315, 3525.761141675029, 1103.2497901427028, 1112.249231768561, 1120.3278033180109, 1124.3591153042769, 1144.874063852984, 11975.46110425033, 11987.280763154238, 11998.760024799456, 12011.699707507381, 12039.759204815855, 4821.252705830602, 4942.728149951788, 4991.226359914219, 4999.175136102503, 5054.646174767805, 9875.654352097787, 9906.702798916043, 9908.752281192883, 9911.900880991241, 9924.454155021398, 5519.779208831602, 5547.0, 5551.417101204396, 5555.055640541118, 5555.472230138131, 4599.33309670096, 5000.524950129732, 5093.439721630618, 5097.8725531861255, 5123.026624941249, 3940.408938659167, 4102.91794164121, 4195.811188496525, 4292.0, 4326.762028088422, 1382.5092092307286, 1405.641561401836, 1413.8727514523741, 1421.374595178139, 1427.4932398998415, 932.1983094538691, 932.7341707613298, 941.0636416765362, 950.3816984208462, 953.2135987809946, 5268.560039860488, 5278.0, 5303.071962406563, 5423.810166644149, 5440.047991601454, 835.6699103854065, 887.5739644970321, 920.3833431600843, 929.1730359979623, 934.9439033657866, 3870.5935876732538, 3887.319719049155, 3899.1421887184774, 3903.1998440320235, 3904.707146963989, 10152.949235253776, 10449.216308776871, 10474.947625261977, 10503.94748026255, 10506.527206275736, 10416.427096509613, 10422.166226701846, 10443.94778026105, 10483.056524912794, 10483.737906552396, 7897.565633890076, 8030.678772849137, 8110.499557581867, 8117.431779775359, 8140.185981401813, 5344.848171289916, 5367.651102678469, 5519.834404967857, 5564.0, 5589.441055894541, 9599.952000239955, 9696.369735967139, 9777.217822574035, 9785.510724463891, 9792.706218813448, 9661.951690241503, 9749.610015599297, 9819.950900245452, 9822.803543929223, 9881.160101391462, 6744.932550674626, 7193.892091618734, 7280.089988751406, 7318.231585683427, 7349.448791340564, 7796.337311328601, 7923.484973476936, 8220.506769593843, 8225.753227403187, 8444.451110677786, 7397.889031664422, 7428.591427471541, 7574.886376704464, 7638.579878106535, 7722.498037627761, 7264.200937896932, 7289.489735718661, 7421.2949769771785, 7444.702211911463, 7547.73582924595, 6991.755288564876, 7103.2541583133025, 7112.146542414944, 7114.075170227838, 7146.821329466805, 4968.602511799119, 4985.4266759323145, 5001.524855138756, 5069.797208111634, 5149.871253218699, 5068.467810879952, 5130.076586214517, 5217.895642087061, 5253.185756207794, 5362.570994320367], "value": 4627.904259340855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.9030100664842, 340.4824666506909, 343.5585272924292, 348.7663265612038, 353.05205523170304, 5141.640085194038, 5261.657992230507, 5271.551918086958, 5327.961047595715, 5343.408446903254, 5131.692098474095, 5250.3699556053325, 5251.632385732991, 5262.657927234727, 5271.762770675319, 4193.972476743203, 4200.70595058346, 4201.369794530814, 4203.831846726127, 4215.241256573816, 4078.6125318094882, 4164.167166566684, 4202.243596152692, 4209.726367786099, 4223.986243301616, 4126.401671757593, 4138.213739389522, 4149.232392007473, 4150.481189851269, 4159.708820382574, 4123.257813593552, 4130.5043394792665, 4136.490181083883, 4147.336426171798, 4162.4796900387455, 3596.1728802375337, 3691.6862066724093, 3708.5894168790232, 3719.3491139050557, 3729.664330210294, 5171.534561889448, 5172.8965420691375, 5192.506711862367, 5196.168613021899, 5199.428062913076, 4766.332713420124, 4771.5467030632035, 4776.068666610013, 4779.569838714532, 4792.688475249098, 5370.516653501204, 5530.391656917735, 5537.0, 5560.610757246995, 5561.304836895388, 4050.4126901599398, 4051.6353528182312, 4060.47213862199, 4064.0, 4065.7560546367017, 5692.487676109128, 5702.54379649627, 5742.454466825645, 5750.792333609947, 5758.3665796762325, 3893.902652433655, 4077.347624380085, 4079.6940229482907, 4091.447654566655, 4139.79301034947, 4122.34042553196, 4131.29767939451, 4135.91728165435, 4138.606832350922, 4142.751434913915, 4711.411073615798, 4715.386999690087, 4723.031778485471, 4729.527047295312, 4731.29030645406, 5379.919301210485, 5512.779488820483, 5599.8600034998635, 5601.131824567198, 5601.163203205817, 1324.6158614001831, 1347.198416941918, 1403.4105675616265, 1425.6435891027243, 1433.5985923941314, 1001.2540657210425, 1023.2070145637042, 1037.1443559063803, 1037.4501514197486, 1038.8805287391895, 5200.829813291979, 5204.453532379046, 5215.687058776485, 5216.321878155815, 5225.973870130625, 5386.730663466811, 5417.322834645669, 5426.457354264542, 5430.70131142791, 5484.314460692413, 5227.523696741624, 5244.695841619831, 5265.4730128263145, 5267.947320526822, 5409.540189083893, 2927.4730548501475, 2956.408718256357, 2963.3332500187284, 2963.6739958604535, 2970.8461365510266, 5695.686737229492, 5740.684262365527, 5771.769129234867, 5807.141714651356, 5818.894410062075, 5543.754779314384, 5681.943180568224, 5699.857503562361, 5722.828315150552, 5724.62428092337, 5852.756751355319, 5853.678047707417, 5861.743228856921, 5868.09044598088, 5882.088411206585, 5371.811986580451, 5600.69196194197, 5622.0, 5630.774769009194, 5638.23883775685, 5553.389127195925, 5566.022178134678, 5571.331440227036, 5574.275344205227, 5579.079451890392, 5841.386654401396, 5842.795502157404, 5845.41545845412, 5851.531877449879, 5879.559507920587, 3881.4954055972544, 4046.9595304046584, 4054.432379466936, 4064.532578753481, 4079.5920407958965, 5516.365617953827, 5543.778248870161, 5559.221708960829, 5612.663240205601, 5621.269234999424, 5489.835304940858, 5564.4991950724625, 5566.777328906798, 5603.439656034364, 5612.186232996111, 5602.0, 5616.297962754656, 5618.634788738719, 5621.044422448112, 5661.179129026351, 5365.490278423544, 5557.41647127062, 5587.664740115606, 5601.871288910188, 5613.971930140323, 5600.439956004367, 5624.943750562442, 5666.34836993751, 5674.659520428788, 5675.602707810579, 5285.392179899361, 5544.7543744783425, 5548.667079975215, 5582.665040097607, 5589.944100559105], "value": 4242.080965131102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.4017366887998, 820.5240960243055, 827.2141465607673, 852.1521086518915, 881.1496905486207, 14947.252637368128, 15702.607434814136, 15753.133577653252, 15793.526194214162, 15832.445864394735, 14803.555893323217, 14923.92538037311, 14954.0, 14977.251137443112, 14988.0, 698.5948150072945, 719.4460265595488, 828.8383765165795, 833.4957350802767, 850.7235148576707, 860.3160487412522, 862.9482231066156, 863.1109956744563, 863.3611127765471, 865.1867244789909, 905.678484138128, 909.2998391238742, 910.1490106750176, 910.2081189365261, 910.4628269321099, 745.9738909138181, 770.3606007014165, 866.8743032260319, 884.4162852517308, 897.1297841094129, 653.0432915778407, 658.5883822610868, 659.5218466611668, 659.5515049766157, 660.3759447322283, 14633.487827925972, 14847.406103755837, 14849.554513364616, 14861.108333500024, 14910.403583856632, 13598.512974101614, 14031.579052628438, 14289.71420571593, 14400.135991840523, 14453.710925781426, 12199.695007624792, 12363.320017399039, 12453.1905426147, 12498.500059997588, 12592.74814503714, 3811.5616704079107, 4408.0, 4441.311596702516, 4507.143642707908, 4556.088782243532, 63157.68421157865, 69083.30916690819, 70459.0, 70479.0, 70714.29285707128, 10785.676429707122, 11057.723556911142, 11220.0, 11264.0, 11700.06399488039, 19749.703754443693, 19821.40535783929, 19851.0, 19995.800041999686, 20009.899950500447, 7872.209422419907, 8055.718049868344, 8184.959075204586, 8223.465474744122, 8242.793930151674, 4764.666473346832, 4895.975520122377, 4925.16272233714, 5022.6233032522705, 5089.389273287155, 3520.0847779577493, 3676.246369494247, 3678.301122786662, 3678.9632103679155, 3684.3920753075977, 588.6056342250703, 606.7360698096343, 609.856683679335, 611.9663418511935, 612.592625903769, 604.0998911621652, 611.4955161991375, 673.7338751193251, 685.2017399729259, 706.5584009993754, 8889.955550222208, 8943.284537237005, 8965.551722413853, 9063.637454501877, 9616.0, 509.0, 524.8058218459119, 533.7696609315487, 564.4412032088203, 578.0, 4397.912041759147, 4530.728156310632, 4631.884202894955, 4713.481517033124, 5020.422651395063, 84352.0, 87061.5646921774, 88539.55730221437, 89772.0, 90961.54519227493, 49585.50414495809, 50358.49641503611, 51901.22148167781, 53538.732306339, 73121.26878731251, 74044.25955740482, 74204.25795742082, 76178.23821761823, 76676.0, 78103.0, 9067.116001056898, 9668.589548629714, 9682.46746428925, 9721.659741909, 9745.366551174151, 48828.26757598568, 49076.0, 49562.0, 49655.0, 50095.49904501054, 39540.40689389604, 54155.72922135364, 54240.45759542354, 59206.0, 65965.67017164883, 11870.525178992744, 12128.878711212776, 12426.937865310616, 12547.43536540876, 12691.175073620185, 14156.858431415554, 14287.357068932131, 14475.420983160555, 14529.0, 14565.781513277521, 10400.375977441076, 13095.934520327337, 13355.933220333836, 13436.93281533586, 14407.927960360132, 12999.740005199654, 13547.729045418839, 13604.115732477358, 13660.931695341857, 13714.588562343146, 12594.24434533931, 12600.621981340575, 12852.293123878277, 12946.482140714266, 13222.735545289233, 10551.630692925712, 11133.83299250528, 11192.328460292409, 11214.831777523506, 11282.097432205568, 11447.0, 11530.250533715282, 11532.481038353462, 11671.066314694974, 11715.472803724024], "value": 7207.175805818671, "unit": "score"}], "name": "dromaeo_css", "value": 7332.136832907026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 123.0, 162.0, 118.0, 123.0, 120.0, 119.0, 146.0, 126.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 101.0, 75.0, 77.0, 76.0, 77.0, 97.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 82.0, 82.0, 83.0, 97.0, 81.0, 83.0, 115.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 49.0, 50.0, 50.0, 51.0, 51.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 57.0, 77.0, 58.0, 58.0, 59.0, 58.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 80.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 126.0, 121.0, 122.0, 123.0, 121.0, 120.0, 169.0, 130.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 157.0, 154.0, 159.0, 154.0, 154.0, 159.0, 158.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 65.0, 62.0, 63.0, 65.0, 60.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1454.9999999999998, "alertThreshold": 2.0}]} 23:53:06 INFO - Return code: 0 23:53:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:53:07 INFO - # TBPL SUCCESS # 23:53:07 INFO - Running post-action listener: _resource_record_post_action 23:53:07 INFO - [mozharness: 2017-01-10 07:53:07.054850Z] Finished run-tests step (success) 23:53:07 INFO - Running post-run listener: _resource_record_post_run 23:53:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 358518784; Read time: 180; Write time: 188204 23:53:07 INFO - TinderboxPrint: CPU usage
13.0% 23:53:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 23:53:07 INFO - TinderboxPrint: I/O write bytes / time
358,518,784 / 188,204 23:53:07 INFO - TinderboxPrint: CPU idle
8,271.0 (87.0%) 23:53:07 INFO - TinderboxPrint: CPU user
1,191.7 (12.5%) 23:53:07 INFO - TinderboxPrint: Swap in / out
0 / 0 23:53:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107417600; Read time: 0; Write time: 69220 23:53:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250130432; Read time: 168; Write time: 118956 23:53:07 INFO - Running post-run listener: _upload_blobber_files 23:53:07 INFO - Blob upload gear active. 23:53:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:53:07 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 23:53:07 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'] 23:53:07 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 23:53:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:11 INFO - (blobuploader) - INFO - Done attempting. 23:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:11 INFO - (blobuploader) - INFO - Done attempting. 23:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:12 INFO - (blobuploader) - INFO - Done attempting. 23:53:12 INFO - (blobuploader) - INFO - Iteration through files over. 23:53:12 INFO - Return code: 0 23:53:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:53:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:53:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20a126ddceb891e270cfe5ece92ae6491482e9e3741b13b1c2236dc4be10e9e87c4ed395f0369d2442754dcf002d7f8e683f153a751ca1582004da876fd6c916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7c0b348fee4733e0a15943f8e91626b7e696c57722654a147f0a9be27bb7f9227ef4cb9e377d6b1dc59cc846604593338c49b01d9820a79d6791cc1f543f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7521756e54f898a8fbfaa2fb5e5998b250ff514031987be9da4fc4b9bece9bea449ca44c4595b614600ce1cffcabcb63fbf05e3e2bde8cb04541d61ec9d6a18"} 23:53:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:53:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:53:12 INFO - Contents: 23:53:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20a126ddceb891e270cfe5ece92ae6491482e9e3741b13b1c2236dc4be10e9e87c4ed395f0369d2442754dcf002d7f8e683f153a751ca1582004da876fd6c916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7c0b348fee4733e0a15943f8e91626b7e696c57722654a147f0a9be27bb7f9227ef4cb9e377d6b1dc59cc846604593338c49b01d9820a79d6791cc1f543f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7521756e54f898a8fbfaa2fb5e5998b250ff514031987be9da4fc4b9bece9bea449ca44c4595b614600ce1cffcabcb63fbf05e3e2bde8cb04541d61ec9d6a18"} 23:53:12 INFO - Running post-run listener: copy_logs_to_upload_dir 23:53:12 INFO - Copying logs to upload dir... 23:53:12 INFO - mkdir: /builds/slave/test/build/upload/logs 23:53:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.747810 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-09 23:53:11.836561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 23:53:11.840452) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 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/20a126ddceb891e270cfe5ece92ae6491482e9e3741b13b1c2236dc4be10e9e87c4ed395f0369d2442754dcf002d7f8e683f153a751ca1582004da876fd6c916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7c0b348fee4733e0a15943f8e91626b7e696c57722654a147f0a9be27bb7f9227ef4cb9e377d6b1dc59cc846604593338c49b01d9820a79d6791cc1f543f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7521756e54f898a8fbfaa2fb5e5998b250ff514031987be9da4fc4b9bece9bea449ca44c4595b614600ce1cffcabcb63fbf05e3e2bde8cb04541d61ec9d6a18"} build_url:https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/MPmc3vHWQC-s9oPhWh8jMw/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/20a126ddceb891e270cfe5ece92ae6491482e9e3741b13b1c2236dc4be10e9e87c4ed395f0369d2442754dcf002d7f8e683f153a751ca1582004da876fd6c916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7c0b348fee4733e0a15943f8e91626b7e696c57722654a147f0a9be27bb7f9227ef4cb9e377d6b1dc59cc846604593338c49b01d9820a79d6791cc1f543f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7521756e54f898a8fbfaa2fb5e5998b250ff514031987be9da4fc4b9bece9bea449ca44c4595b614600ce1cffcabcb63fbf05e3e2bde8cb04541d61ec9d6a18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 23:53:11.869512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:53:11.869832) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1484030649.556631-53509349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 23:53:11.954807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 23:53:11.955125) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 23:53:11.955406) ========= ========= Total master_lag: 0.22 =========