builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1479469726.65 results: success (0) buildid: 20161118004020 builduid: 83a5f4abf7c043e5a7aef121e809f673 revision: 7ad438df29922ee13d21100873883eb9dd93423c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.651397) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.651834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.652105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.666523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.666824) ========= 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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 03:48:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.5M=0s 2016-11-18 03:48:46 (89.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091630 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.772610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.772995) ========= 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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.822396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:46.822758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ad438df29922ee13d21100873883eb9dd93423c --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 7ad438df29922ee13d21100873883eb9dd93423c --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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 03:48:46,874 truncating revision to first 12 chars 2016-11-18 03:48:46,874 Setting DEBUG logging. 2016-11-18 03:48:46,874 attempt 1/10 2016-11-18 03:48:46,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ad438df2992?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 03:48:47,192 unpacking tar archive at: mozilla-aurora-7ad438df2992/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:47.460691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:47.461010) ========= script_repo_revision: 7ad438df29922ee13d21100873883eb9dd93423c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:47.461397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:47.461677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:48:47.469807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-18 03:48:47.470080) ========= /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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:47 INFO - MultiFileLogger online at 20161118 03:48:47 in /builds/slave/test 03:48:47 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 03:48:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:47 INFO - {'append_to_log': False, 03:48:47 INFO - 'base_work_dir': '/builds/slave/test', 03:48:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:48:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:47 INFO - 'branch': 'Mozilla-Aurora', 03:48:47 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:47 INFO - 'config_files': ('talos/linux_config.py',), 03:48:47 INFO - 'default_actions': ('clobber', 03:48:47 INFO - 'read-buildbot-config', 03:48:47 INFO - 'download-and-extract', 03:48:47 INFO - 'populate-webroot', 03:48:47 INFO - 'create-virtualenv', 03:48:47 INFO - 'install', 03:48:47 INFO - 'run-tests'), 03:48:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:47 INFO - 'download_minidump_stackwalk': True, 03:48:47 INFO - 'download_symbols': 'ondemand', 03:48:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:47 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:47 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:47 INFO - 'installer_path': 'installer.exe', 03:48:47 INFO - 'log_level': 'info', 03:48:47 INFO - 'log_name': 'talos', 03:48:47 INFO - 'log_to_console': True, 03:48:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:47 INFO - 'opt_config_files': (), 03:48:47 INFO - 'pip_index': False, 03:48:47 INFO - 'sps_profile': False, 03:48:47 INFO - 'sps_profile_interval': 0, 03:48:47 INFO - 'suite': 'dromaeojs', 03:48:47 INFO - 'system_bits': '32', 03:48:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:47 INFO - 'title': 'talos-linux64-ix-026', 03:48:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:47 INFO - 'use_talos_json': True, 03:48:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:47 INFO - 'work_dir': 'build'} 03:48:47 INFO - [mozharness: 2016-11-18 11:48:47.613423Z] Running clobber step. 03:48:47 INFO - Running pre-action listener: _resource_record_pre_action 03:48:47 INFO - Running main action method: clobber 03:48:47 INFO - rmtree: /builds/slave/test/build 03:48:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:48 INFO - Running post-action listener: _resource_record_post_action 03:48:48 INFO - [mozharness: 2016-11-18 11:48:48.072184Z] Finished clobber step (success) 03:48:48 INFO - [mozharness: 2016-11-18 11:48:48.072284Z] Running read-buildbot-config step. 03:48:48 INFO - Running pre-action listener: _resource_record_pre_action 03:48:48 INFO - Running main action method: read_buildbot_config 03:48:48 INFO - Using buildbot properties: 03:48:48 INFO - { 03:48:48 INFO - "project": "", 03:48:48 INFO - "product": "firefox", 03:48:48 INFO - "script_repo_revision": "production", 03:48:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:48:48 INFO - "repository": "", 03:48:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:48:48 INFO - "buildid": "20161118004020", 03:48:48 INFO - "stage_platform": "linux64-pgo", 03:48:48 INFO - "basedir": "/builds/slave/test", 03:48:48 INFO - "nightly_build": "True", 03:48:48 INFO - "buildnumber": 913, 03:48:48 INFO - "slavename": "talos-linux64-ix-026", 03:48:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:48:48 INFO - "platform": "ubuntu64_hw", 03:48:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:48:48 INFO - "branch": "mozilla-aurora", 03:48:48 INFO - "repo_path": "releases/mozilla-aurora", 03:48:48 INFO - "revision": "7ad438df29922ee13d21100873883eb9dd93423c", 03:48:48 INFO - "pgo_build": "True", 03:48:48 INFO - "builduid": "83a5f4abf7c043e5a7aef121e809f673", 03:48:48 INFO - "slavebuilddir": "test" 03:48:48 INFO - } 03:48:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:48:48 INFO - Running post-action listener: _resource_record_post_action 03:48:48 INFO - [mozharness: 2016-11-18 11:48:48.075311Z] Finished read-buildbot-config step (success) 03:48:48 INFO - [mozharness: 2016-11-18 11:48:48.075399Z] Running download-and-extract step. 03:48:48 INFO - Running pre-action listener: _resource_record_pre_action 03:48:48 INFO - Running main action method: download_and_extract 03:48:48 INFO - mkdir: /builds/slave/test/build/tests 03:48:48 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')]} 03:48:48 INFO - trying https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:48:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/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 03:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/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 03:48:48 INFO - Downloaded 1361 bytes. 03:48:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:48:48 INFO - Using the following test package requirements: 03:48:48 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:48:48 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:48 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:48:48 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'jsshell-linux-x86_64.zip'], 03:48:48 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:48 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:48:48 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:48:48 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:48:48 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:48 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:48:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:48:49 INFO - Http code: 200 03:48:49 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 03:48:49 INFO - x-amz-cf-id: fkQouPLtYpxK8O65nBtcL5ejVFgGcVSV2DEX0xOOb4ek3NIxUxWqcw== 03:48:49 INFO - x-amz-version-id: T_ZNntybAzzwqP8684x.19OLFVTOhfIl 03:48:49 INFO - Expected file size: 22000071 03:48:49 INFO - Obtained file size: 22000071 03:48:53 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 03:48:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:48:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:48:53 INFO - Http code: 200 03:48:53 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 03:48:53 INFO - x-amz-cf-id: MMkaCNfaas9NjPCk5BHgYrY74BSMKTanQTeGjfz5hpddIepggDVSHA== 03:48:53 INFO - x-amz-version-id: T_ZNntybAzzwqP8684x.19OLFVTOhfIl 03:48:54 INFO - Expected file size: 22000071 03:48:54 INFO - Obtained file size: 22000071 03:48:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:48:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:48:59 INFO - Http code: 200 03:48:59 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 03:48:59 INFO - x-amz-cf-id: 61RcuHbTceOv8nZIft_83Pjc9utakJZBzJBCS8cdgFTlWwyem5Vofg== 03:48:59 INFO - x-amz-version-id: LQMP0JpMFqUO.rFGt4LdP6M1H9uQvcuZ 03:48:59 INFO - Expected file size: 14409038 03:48:59 INFO - Obtained file size: 14409038 03:48: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')]} 03:48:59 INFO - trying https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/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 03:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/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 03:49:00 INFO - Downloaded 63926064 bytes. 03:49:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:49:00 INFO - mkdir: /builds/slave/test/properties 03:49:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:00 INFO - Contents: 03:49:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:49:01 INFO - Running post-action listener: _resource_record_post_action 03:49:01 INFO - Running post-action listener: set_extra_try_arguments 03:49:01 INFO - [mozharness: 2016-11-18 11:49:01.579728Z] Finished download-and-extract step (success) 03:49:01 INFO - [mozharness: 2016-11-18 11:49:01.579954Z] Running populate-webroot step. 03:49:01 INFO - Running pre-action listener: _resource_record_pre_action 03:49:01 INFO - Running main action method: populate_webroot 03:49:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:49:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:49:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:49:01 INFO - '--tppagecycles', 03:49:01 INFO - '7'], 03:49:01 INFO - 'tests': ['tsvgm']}}, 03:49:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:49:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:49:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:49:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:49:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['damp', 'tps']}, 03:49:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['damp', 'tps']}, 03:49:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['dromaeo_dom']}, 03:49:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['basic_compositor_video']}, 03:49:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:49:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['a11yr', 03:49:01 INFO - 'ts_paint', 03:49:01 INFO - 'tpaint', 03:49:01 INFO - 'sessionrestore', 03:49:01 INFO - 'sessionrestore_no_auto_restore', 03:49:01 INFO - 'tabpaint']}, 03:49:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['tsvgx', 03:49:01 INFO - 'tsvgr_opacity', 03:49:01 INFO - 'tart', 03:49:01 INFO - 'tscrollx', 03:49:01 INFO - 'cart']}, 03:49:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:49:01 INFO - 'tsvgr_opacity', 03:49:01 INFO - 'tart', 03:49:01 INFO - 'tscrollx', 03:49:01 INFO - 'cart']}, 03:49:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--disable-e10s'], 03:49:01 INFO - 'tests': ['tp5o']}, 03:49:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'tests': ['tp5o']}, 03:49:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--disable-e10s', 03:49:01 INFO - '--xperf_path', 03:49:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:01 INFO - 'tests': ['tp5n']}, 03:49:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:01 INFO - 'talos_options': ['--xperf_path', 03:49:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:01 INFO - 'tests': ['tp5n']}}, 03:49:01 INFO - 'talos.zip': {'path': '', 03:49:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:49:01 INFO - Running post-action listener: _resource_record_post_action 03:49:01 INFO - [mozharness: 2016-11-18 11:49:01.599046Z] Finished populate-webroot step (success) 03:49:01 INFO - [mozharness: 2016-11-18 11:49:01.599134Z] Running create-virtualenv step. 03:49:01 INFO - Running pre-action listener: _resource_record_pre_action 03:49:01 INFO - Running main action method: create_virtualenv 03:49:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:01 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 03:49:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:49:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:01 INFO - Using real prefix '/usr' 03:49:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:04 INFO - Installing pip.................done. 03:49:04 INFO - Return code: 0 03:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:49:04 INFO - Reading from file tmpfile_stdout 03:49:04 INFO - Output received: 03:49:04 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) 03:49:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49: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', 'pip>=1.5'] in /builds/slave/test/build 03:49: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 pip>=1.5 03:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 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 03:49:04 INFO - Cleaning up... 03:49:04 INFO - Return code: 0 03:49:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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', '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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:49: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 psutil>=3.1.1 03:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 INFO - Downloading/unpacking psutil>=3.1.1 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:06 INFO - Installing collected packages: psutil 03:49:06 INFO - Running setup.py install for psutil 03:49:06 INFO - building 'psutil._psutil_linux' extension 03:49:06 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 03:49:07 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 03:49:07 INFO - building 'psutil._psutil_posix' extension 03:49:07 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 03:49:07 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 03:49:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:07 INFO - Successfully installed psutil 03:49:07 INFO - Cleaning up... 03:49:07 INFO - Return code: 0 03:49:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:49:07 INFO - Using env: {'DISPLAY': ':0', 03:49:07 INFO - 'HOME': '/home/cltbld', 03:49:07 INFO - 'LANG': 'en_US.UTF-8', 03:49:07 INFO - 'LANGUAGE': 'en_US:en', 03:49:07 INFO - 'LOGNAME': 'cltbld', 03:49:07 INFO - 'MAIL': '/var/mail/cltbld', 03:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:07 INFO - 'MOZ_NO_REMOTE': '1', 03:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:07 INFO - 'NO_EM_RESTART': '1', 03:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:07 INFO - 'PWD': '/builds/slave/test', 03:49:07 INFO - 'SHELL': '/bin/bash', 03:49:07 INFO - 'SHLVL': '1', 03:49:07 INFO - 'TERM': 'linux', 03:49:07 INFO - 'TMOUT': '86400', 03:49:07 INFO - 'USER': 'cltbld', 03:49:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:07 INFO - '_': '/tools/buildbot/bin/python'} 03:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:49:09 INFO - Installing collected packages: mozsystemmonitor 03:49:09 INFO - Running setup.py install for mozsystemmonitor 03:49:09 INFO - Successfully installed mozsystemmonitor 03:49:09 INFO - Cleaning up... 03:49:09 INFO - Return code: 0 03:49:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:49:09 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')]} 03:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:09 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')]} 03:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:09 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:09 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 03:49:09 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 03:49:09 INFO - Using env: {'DISPLAY': ':0', 03:49:09 INFO - 'HOME': '/home/cltbld', 03:49:09 INFO - 'LANG': 'en_US.UTF-8', 03:49:09 INFO - 'LANGUAGE': 'en_US:en', 03:49:09 INFO - 'LOGNAME': 'cltbld', 03:49:09 INFO - 'MAIL': '/var/mail/cltbld', 03:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:09 INFO - 'MOZ_NO_REMOTE': '1', 03:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:09 INFO - 'NO_EM_RESTART': '1', 03:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:09 INFO - 'PWD': '/builds/slave/test', 03:49:09 INFO - 'SHELL': '/bin/bash', 03:49:09 INFO - 'SHLVL': '1', 03:49:09 INFO - 'TERM': 'linux', 03:49:09 INFO - 'TMOUT': '86400', 03:49:09 INFO - 'USER': 'cltbld', 03:49:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:09 INFO - '_': '/tools/buildbot/bin/python'} 03:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:49:11 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 03:49:11 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 03:49:11 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 03:49:11 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 03:49:11 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 03:49:11 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 03:49:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:12 INFO - warning: no files found matching '*.txt' 03:49:12 INFO - no previously-included directories found matching 'build' 03:49:12 INFO - no previously-included directories found matching 'dist' 03:49:12 INFO - no previously-included directories found matching '.git*' 03:49:12 INFO - Installing collected packages: jsonschema, functools32 03:49:12 INFO - Running setup.py install for functools32 03:49:12 INFO - warning: no files found matching '*.txt' 03:49:12 INFO - no previously-included directories found matching 'build' 03:49:12 INFO - no previously-included directories found matching 'dist' 03:49:12 INFO - no previously-included directories found matching '.git*' 03:49:12 INFO - Successfully installed jsonschema functools32 03:49:12 INFO - Cleaning up... 03:49:12 INFO - Return code: 0 03:49:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:49:12 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')]} 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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')]} 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:12 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 03:49:12 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 03:49:12 INFO - Using env: {'DISPLAY': ':0', 03:49:12 INFO - 'HOME': '/home/cltbld', 03:49:12 INFO - 'LANG': 'en_US.UTF-8', 03:49:12 INFO - 'LANGUAGE': 'en_US:en', 03:49:12 INFO - 'LOGNAME': 'cltbld', 03:49:12 INFO - 'MAIL': '/var/mail/cltbld', 03:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:12 INFO - 'MOZ_NO_REMOTE': '1', 03:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:12 INFO - 'NO_EM_RESTART': '1', 03:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:12 INFO - 'PWD': '/builds/slave/test', 03:49:12 INFO - 'SHELL': '/bin/bash', 03:49:12 INFO - 'SHLVL': '1', 03:49:12 INFO - 'TERM': 'linux', 03:49:12 INFO - 'TMOUT': '86400', 03:49:12 INFO - 'USER': 'cltbld', 03:49:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:12 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:49:12 INFO - Cleaning up... 03:49:12 INFO - Return code: 0 03:49:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49:12 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')]} 03:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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')]} 03:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:12 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:12 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 03:49:12 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 03:49:12 INFO - Using env: {'DISPLAY': ':0', 03:49:12 INFO - 'HOME': '/home/cltbld', 03:49:12 INFO - 'LANG': 'en_US.UTF-8', 03:49:12 INFO - 'LANGUAGE': 'en_US:en', 03:49:12 INFO - 'LOGNAME': 'cltbld', 03:49:12 INFO - 'MAIL': '/var/mail/cltbld', 03:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:12 INFO - 'MOZ_NO_REMOTE': '1', 03:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:12 INFO - 'NO_EM_RESTART': '1', 03:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:12 INFO - 'PWD': '/builds/slave/test', 03:49:12 INFO - 'SHELL': '/bin/bash', 03:49:12 INFO - 'SHLVL': '1', 03:49:12 INFO - 'TERM': 'linux', 03:49:12 INFO - 'TMOUT': '86400', 03:49:12 INFO - 'USER': 'cltbld', 03:49:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:12 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49:14 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 03:49:14 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 03:49:14 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 03:49:14 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 03:49:14 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 03:49:14 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 03:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:15 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 03:49:15 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 03:49:15 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 03:49:15 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 03:49:15 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 03:49:15 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 03:49:15 INFO - Downloading docopt-0.6.1.tar.gz 03:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:15 INFO - Running setup.py install for blobuploader 03:49:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:15 INFO - Running setup.py install for requests 03:49:16 INFO - Running setup.py install for docopt 03:49:16 INFO - Successfully installed blobuploader requests docopt 03:49:16 INFO - Cleaning up... 03:49:16 INFO - Return code: 0 03:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:16 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')]} 03:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:16 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')]} 03:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:16 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:16 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 03:49:16 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 03:49:16 INFO - Using env: {'DISPLAY': ':0', 03:49:16 INFO - 'HOME': '/home/cltbld', 03:49:16 INFO - 'LANG': 'en_US.UTF-8', 03:49:16 INFO - 'LANGUAGE': 'en_US:en', 03:49:16 INFO - 'LOGNAME': 'cltbld', 03:49:16 INFO - 'MAIL': '/var/mail/cltbld', 03:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:16 INFO - 'MOZ_NO_REMOTE': '1', 03:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:16 INFO - 'NO_EM_RESTART': '1', 03:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:16 INFO - 'PWD': '/builds/slave/test', 03:49:16 INFO - 'SHELL': '/bin/bash', 03:49:16 INFO - 'SHLVL': '1', 03:49:16 INFO - 'TERM': 'linux', 03:49:16 INFO - 'TMOUT': '86400', 03:49:16 INFO - 'USER': 'cltbld', 03:49:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:16 INFO - '_': '/tools/buildbot/bin/python'} 03:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:16 INFO - Running setup.py (path:/tmp/pip-piafWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:16 INFO - Running setup.py (path:/tmp/pip-VYMrq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:16 INFO - Running setup.py (path:/tmp/pip-dZE4f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:16 INFO - Running setup.py (path:/tmp/pip-BzblGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:16 INFO - Running setup.py (path:/tmp/pip-_5H07c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:16 INFO - Running setup.py (path:/tmp/pip-GaW_jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:16 INFO - Running setup.py (path:/tmp/pip-SBLh2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:16 INFO - Running setup.py (path:/tmp/pip-Ha034q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:16 INFO - Running setup.py (path:/tmp/pip-ppujNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:17 INFO - Running setup.py (path:/tmp/pip-LVpE2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:17 INFO - Running setup.py (path:/tmp/pip-jke6Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:17 INFO - Running setup.py (path:/tmp/pip-zhrsER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:17 INFO - Running setup.py (path:/tmp/pip-gKuQnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:17 INFO - Running setup.py (path:/tmp/pip-xv88Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:17 INFO - Running setup.py (path:/tmp/pip-caIGuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:17 INFO - Running setup.py (path:/tmp/pip-w7b4LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:17 INFO - Running setup.py (path:/tmp/pip-hU8nYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:17 INFO - Running setup.py install for manifestparser 03:49:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:49:17 INFO - Running setup.py install for mozcrash 03:49:17 INFO - Running setup.py install for mozdebug 03:49:17 INFO - Running setup.py install for mozdevice 03:49:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozfile 03:49:18 INFO - Running setup.py install for mozhttpd 03:49:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozinfo 03:49:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozInstall 03:49:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozleak 03:49:18 INFO - Running setup.py install for mozlog 03:49:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for moznetwork 03:49:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozprocess 03:49:18 INFO - Running setup.py install for mozprofile 03:49:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:18 INFO - Running setup.py install for mozrunner 03:49:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:19 INFO - Running setup.py install for mozscreenshot 03:49:19 INFO - Running setup.py install for moztest 03:49:19 INFO - Running setup.py install for mozversion 03:49:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:19 INFO - Cleaning up... 03:49:19 INFO - Return code: 0 03:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:19 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')]} 03:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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')]} 03:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:19 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:19 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 03:49:19 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 03:49:19 INFO - Using env: {'DISPLAY': ':0', 03:49:19 INFO - 'HOME': '/home/cltbld', 03:49:19 INFO - 'LANG': 'en_US.UTF-8', 03:49:19 INFO - 'LANGUAGE': 'en_US:en', 03:49:19 INFO - 'LOGNAME': 'cltbld', 03:49:19 INFO - 'MAIL': '/var/mail/cltbld', 03:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:19 INFO - 'MOZ_NO_REMOTE': '1', 03:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:19 INFO - 'NO_EM_RESTART': '1', 03:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:19 INFO - 'PWD': '/builds/slave/test', 03:49:19 INFO - 'SHELL': '/bin/bash', 03:49:19 INFO - 'SHLVL': '1', 03:49:19 INFO - 'TERM': 'linux', 03:49:19 INFO - 'TMOUT': '86400', 03:49:19 INFO - 'USER': 'cltbld', 03:49:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:19 INFO - '_': '/tools/buildbot/bin/python'} 03:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:19 INFO - Running setup.py (path:/tmp/pip-NpoA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:19 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)) 03:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:19 INFO - Running setup.py (path:/tmp/pip-RekSbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:19 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)) 03:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:19 INFO - Running setup.py (path:/tmp/pip-nz1fOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:19 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)) 03:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:19 INFO - Running setup.py (path:/tmp/pip-oOCkju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:19 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)) 03:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:19 INFO - Running setup.py (path:/tmp/pip-59YdGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:20 INFO - Running setup.py (path:/tmp/pip-lgvRkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:20 INFO - Running setup.py (path:/tmp/pip-StwwP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:20 INFO - Running setup.py (path:/tmp/pip-_LUpiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:20 INFO - Running setup.py (path:/tmp/pip-Zml97W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:20 INFO - Running setup.py (path:/tmp/pip-ISCteS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:20 INFO - Running setup.py (path:/tmp/pip-B5GBSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:20 INFO - Running setup.py (path:/tmp/pip-m1KU7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:20 INFO - Running setup.py (path:/tmp/pip-gS4jh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:20 INFO - Running setup.py (path:/tmp/pip-RNQVgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:20 INFO - Running setup.py (path:/tmp/pip-RvChPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:20 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)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:20 INFO - Running setup.py (path:/tmp/pip-pHmS8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:20 INFO - Running setup.py (path:/tmp/pip-e4103s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:20 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)) 03:49:20 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)) 03:49:20 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)) 03:49:20 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)) 03:49:20 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)) 03:49:20 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)) 03:49:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - Downloading blessings-1.6.tar.gz 03:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:22 INFO - Installing collected packages: blessings 03:49:22 INFO - Running setup.py install for blessings 03:49:23 INFO - Successfully installed blessings 03:49:23 INFO - Cleaning up... 03:49:23 INFO - Return code: 0 03:49:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:23 INFO - Reading from file tmpfile_stdout 03:49:23 INFO - Current package versions: 03:49:23 INFO - argparse == 1.2.1 03:49:23 INFO - blessings == 1.6 03:49:23 INFO - blobuploader == 1.2.4 03:49:23 INFO - docopt == 0.6.1 03:49:23 INFO - functools32 == 3.2.3-2 03:49:23 INFO - jsonschema == 2.5.1 03:49:23 INFO - manifestparser == 1.1 03:49:23 INFO - mozInstall == 1.12 03:49:23 INFO - mozcrash == 1.0 03:49:23 INFO - mozdebug == 0.1 03:49:23 INFO - mozdevice == 0.48 03:49:23 INFO - mozfile == 1.2 03:49:23 INFO - mozhttpd == 0.7 03:49:23 INFO - mozinfo == 0.9 03:49:23 INFO - mozleak == 0.1 03:49:23 INFO - mozlog == 3.4 03:49:23 INFO - moznetwork == 0.27 03:49:23 INFO - mozprocess == 0.23 03:49:23 INFO - mozprofile == 0.28 03:49:23 INFO - mozrunner == 6.13 03:49:23 INFO - mozscreenshot == 0.1 03:49:23 INFO - mozsystemmonitor == 0.3 03:49:23 INFO - moztest == 0.7 03:49:23 INFO - mozversion == 1.4 03:49:23 INFO - psutil == 3.1.1 03:49:23 INFO - requests == 1.2.3 03:49:23 INFO - wsgiref == 0.1.2 03:49:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 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 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:23 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 03:49:23 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 03:49:23 INFO - Using env: {'DISPLAY': ':0', 03:49:23 INFO - 'HOME': '/home/cltbld', 03:49:23 INFO - 'LANG': 'en_US.UTF-8', 03:49:23 INFO - 'LANGUAGE': 'en_US:en', 03:49:23 INFO - 'LOGNAME': 'cltbld', 03:49:23 INFO - 'MAIL': '/var/mail/cltbld', 03:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:23 INFO - 'MOZ_NO_REMOTE': '1', 03:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:23 INFO - 'NO_EM_RESTART': '1', 03:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:23 INFO - 'PWD': '/builds/slave/test', 03:49:23 INFO - 'SHELL': '/bin/bash', 03:49:23 INFO - 'SHLVL': '1', 03:49:23 INFO - 'TERM': 'linux', 03:49:23 INFO - 'TMOUT': '86400', 03:49:23 INFO - 'USER': 'cltbld', 03:49:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:23 INFO - '_': '/tools/buildbot/bin/python'} 03:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 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)) 03:49:23 INFO - Cleaning up... 03:49:23 INFO - Return code: 0 03:49:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ee7935f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, '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': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', '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 03:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:49:23 INFO - Using env: {'DISPLAY': ':0', 03:49:23 INFO - 'HOME': '/home/cltbld', 03:49:23 INFO - 'LANG': 'en_US.UTF-8', 03:49:23 INFO - 'LANGUAGE': 'en_US:en', 03:49:23 INFO - 'LOGNAME': 'cltbld', 03:49:23 INFO - 'MAIL': '/var/mail/cltbld', 03:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:23 INFO - 'MOZ_NO_REMOTE': '1', 03:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:23 INFO - 'NO_EM_RESTART': '1', 03:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:23 INFO - 'PWD': '/builds/slave/test', 03:49:23 INFO - 'SHELL': '/bin/bash', 03:49:23 INFO - 'SHLVL': '1', 03:49:23 INFO - 'TERM': 'linux', 03:49:23 INFO - 'TMOUT': '86400', 03:49:23 INFO - 'USER': 'cltbld', 03:49:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:23 INFO - '_': '/tools/buildbot/bin/python'} 03:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:49:23 INFO - Cleaning up... 03:49:23 INFO - Return code: 0 03:49:23 INFO - Running post-action listener: _resource_record_post_action 03:49:23 INFO - Running post-action listener: _start_resource_monitoring 03:49:23 INFO - Starting resource monitoring. 03:49:23 INFO - [mozharness: 2016-11-18 11:49:23.790701Z] Finished create-virtualenv step (success) 03:49:23 INFO - [mozharness: 2016-11-18 11:49:23.791209Z] Running install step. 03:49:23 INFO - Running pre-action listener: _resource_record_pre_action 03:49:23 INFO - Running main action method: install 03:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:24 INFO - Reading from file tmpfile_stdout 03:49:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:24 INFO - Reading from file tmpfile_stdout 03:49:24 INFO - Output received: 03:49:24 INFO - Usage: mozinstall [options] installer 03:49:24 INFO - Options: 03:49:24 INFO - -h, --help show this help message and exit 03:49:24 INFO - -d DEST, --destination=DEST 03:49:24 INFO - Directory to install application into. [default: 03:49:24 INFO - "/builds/slave/test"] 03:49:24 INFO - --app=APP Application being installed. [default: firefox] 03:49:24 INFO - mkdir: /builds/slave/test/build/application 03:49:24 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'] 03:49:24 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 03:49:39 INFO - Reading from file tmpfile_stdout 03:49:39 INFO - Output received: 03:49:39 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:39 INFO - Running post-action listener: _resource_record_post_action 03:49:39 INFO - [mozharness: 2016-11-18 11:49:39.986224Z] Finished install step (success) 03:49:39 INFO - [mozharness: 2016-11-18 11:49:39.986467Z] Running run-tests step. 03:49:39 INFO - Running pre-action listener: _resource_record_pre_action 03:49:39 INFO - Running main action method: run_tests 03:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:39 INFO - Python 2.7.3 03:49:39 INFO - Return code: 0 03:49:39 INFO - grabbing minidump binary from tooltool 03:49: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')]} 03:49:39 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 0x12aef60>, '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 0x12afd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:39 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 03:49:39 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 03:49:39 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 03:49:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:40 INFO - Return code: 0 03:49:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:40 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/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 03:49:40 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/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 03:49:40 INFO - Using env: {'DISPLAY': ':0', 03:49:40 INFO - 'HOME': '/home/cltbld', 03:49:40 INFO - 'LANG': 'en_US.UTF-8', 03:49:40 INFO - 'LANGUAGE': 'en_US:en', 03:49:40 INFO - 'LOGNAME': 'cltbld', 03:49:40 INFO - 'MAIL': '/var/mail/cltbld', 03:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:40 INFO - 'MOZ_NO_REMOTE': '1', 03:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:40 INFO - 'NO_EM_RESTART': '1', 03:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:40 INFO - 'PWD': '/builds/slave/test', 03:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:40 INFO - 'SHELL': '/bin/bash', 03:49:40 INFO - 'SHLVL': '1', 03:49:40 INFO - 'TERM': 'linux', 03:49:40 INFO - 'TMOUT': '86400', 03:49:40 INFO - 'USER': 'cltbld', 03:49:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418', 03:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:40 INFO - '_': '/tools/buildbot/bin/python'} 03:49:40 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/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 03:49:40 INFO - mozversion application_buildid: 20161118004020 03:49:40 INFO - mozversion application_changeset: 7ad438df29922ee13d21100873883eb9dd93423c 03:49:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:49:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:40 INFO - mozversion application_name: Firefox 03:49:40 INFO - mozversion application_remotingname: firefox-dev 03:49:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:49:40 INFO - mozversion application_vendor: Mozilla 03:49:40 INFO - mozversion application_version: 52.0a2 03:49:40 INFO - mozversion platform_buildid: 20161118004020 03:49:40 INFO - mozversion platform_changeset: 7ad438df29922ee13d21100873883eb9dd93423c 03:49:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:49:40 INFO - mozversion platform_version: 52.0a2 03:49:40 INFO - using testdate: 1479469780 03:49:40 INFO - actual date: 1479469780 03:49:40 INFO - starting webserver on 'localhost:42672' 03:49:40 INFO - SUITE-START | Running 2 tests 03:49:40 INFO - TEST-START | dromaeo_css 03:49:40 INFO - operating with platform_type : linux_ 03:49:40 INFO - Initialising browser for dromaeo_css test... 03:49:40 INFO - TEST-INFO | started process 11900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOBSgOj/profile http://localhost:42672/getInfo.html) 03:49:43 ERROR - PROCESS | 11900 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:49:44 INFO - PROCESS | 11900 | __metrics Screen width/height:1600/1200 03:49:44 INFO - PROCESS | 11900 | colorDepth:24 03:49:44 INFO - PROCESS | 11900 | Browser inner width/height: 1024/697 03:49:44 INFO - PROCESS | 11900 | __metrics 03:49:44 INFO - PROCESS | 11900 | 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" 03:49:44 INFO - PROCESS | 11900 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:45 INFO - PROCESS | 11900 | console.error: PushService: 03:49:45 INFO - PROCESS | 11900 | stateChangeProcessEnqueue: Error transitioning state 03:49:45 INFO - PROCESS | 11900 | UnknownError 03:49:45 INFO - TEST-INFO | 11900: exit 0 03:49:45 INFO - Browser initialized. 03:49:45 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:45 INFO - TEST-INFO | started process 11992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOBSgOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:57 INFO - PROCESS | 11992 | RSS: Main: 144961536 03:49:57 INFO - PROCESS | 11992 | 03:50:49 INFO - PROCESS | 11992 | 1479469849355 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:52:59 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42672/tests/dromaeo/cssquery-ext.html) 03:53:00 INFO - PROCESS | 11992 | RSS: Main: 248156160 03:53:00 INFO - PROCESS | 11992 | 03:56:03 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-ext.html (next: http://localhost:42672/tests/dromaeo/cssquery-jquery.html) 03:56:03 INFO - PROCESS | 11992 | RSS: Main: 226738176 03:56:03 INFO - PROCESS | 11992 | 03:59:05 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42672/tests/dromaeo/cssquery-mootools.html) 03:59:06 INFO - PROCESS | 11992 | RSS: Main: 218021888 03:59:06 INFO - PROCESS | 11992 | 04:02:08 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42672/tests/dromaeo/cssquery-prototype.html) 04:02:08 INFO - PROCESS | 11992 | RSS: Main: 215588864 04:02:08 INFO - PROCESS | 11992 | 04:05:11 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42672/tests/dromaeo/cssquery-yui.html) 04:05:12 INFO - PROCESS | 11992 | RSS: Main: 173240320 04:05:12 INFO - PROCESS | 11992 | 04:08:14 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:42672/tests/dromaeo/cssquery-yui.html (next: http://localhost:42672/tests/dromaeo/cssquery-dojo.html) 04:08:15 INFO - PROCESS | 11992 | RSS: Main: 263700480 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | __start_tp_report 04:08:15 INFO - PROCESS | 11992 | _x_x_mozilla_page_load 04:08:15 INFO - PROCESS | 11992 | _x_x_mozilla_page_load_details 04:08:15 INFO - PROCESS | 11992 | |i|pagename|runs| 04:08:15 INFO - PROCESS | 11992 | |0;dojo.html;3208.4224839528883;3253.837308134594;3268.444364458043;3271.869125234991;3289.5723555937725;5614.29821272341;5651.8304450866435;5653.208550802891;5673.489385955263;5696.174054762057;5598.776048958047;5654.236678048463;5657.094864821629;5667.064934285838;5680.261565996425;5073.492650734934;5085.3389059422225;5104.387473503185;5142.04872098663;5160.690358578498;4968.403791545002;4984.252362145671;5186.247994040862;5186.351706036746;5190.92213616796;5057.963117560909;5075.695458272516;5104.183330667094;5117.309163262968;5141.768620412072;5135.871603209912;5195.038917800219;5199.870003249949;5202.609804264657;5221.6083793715625;4902.264660300983;5109.259157422191;5136.229565565195;5164.535191832715;5193.350831146106;5464.508194262496;5479.0959491683825;5481.424450432727;5506.862328441781;5539.279893613804;5925.703714814285;5958.731857066442;6012.549058820562;6027.7287522061615;6037.154798328237;5867.471927526543;6088.056351265561;6099.054646529795;6100.572959892809;6100.908486372708;5522.585806064561;5583.134614134816;5696.886062278814;5703.971480142573;5705.5150312223095;6242.968785156136;6250.562460627803;6250.781222657185;6251.0623406488485;6261.655608941552;5802.65184088956;5984.102384642339;6003.249593800775;6006.699665016732;6011.669358185254;5928.407159284124;5929.0513517836935;5989.8203053908455;6004.639721616717;6058.273007239071;5982.192404025488;5996.340402555716;5999.160117583542;6003.429674180946;6034.24571928509;5960.046392577254;6001;6010.4891084258325;6020.247469066367;6020.729067191987;4515.525869783691;4577.748223847654;4582.518835522289;4623.075384923029;4646.907061858744;4115.279826030493;4157.771322577288;4161.91676166475;4170.52039015511;4172.937405938914;5781.8554536136935;5784.363719990798;5794.507466865363;5796.536277097822;5799.971000145057;5881.382454842265;5899;5938.554608404387;5979.19280897082;6082.452579267887;5666.914996275059;5668.943310566924;5672.517835983987;5678.829635110953;5701.743421546041;5114.539691427789;5123.077845987758;5127.230915362726;5132.153194722829;5139.820106296262;6017.819465416044;6114.814446323713;6148.415900489446;6201.10084037812;6220.533459990428;5993.760249590142;6087.908681369694;6092.939070609237;6131.325554189125;6133.877322453615;6296.653684047421;6299.622022678654;6324.620522768649;6336.049592561153;6343.143675603735;5794.478496935296;5801.709914504342;5971.134185542985;5973.880522389615;5976.581639285208;5937.9406205937385;6024.1265016573225;6025.0661147522205;6092.8172154833655;6103.725332359965;5912.911306330322;5947.434993675594;5957.076653118774;5964.9105263420215;5970.940290597038;5668.26312579362;5906.970465147647;5921.970390148022;5930.406959304035;5935.169076329231;5769.394213607511;5832.24180856486;5896.469317761251;5897.174395584536;5969.462748352669;5975.850603734768;5993.370696077023;6006.15913772081;6011.549133814894;6013.789517366871;5661.377248502744;5680.233168522197;5717.285339332583;5852.590318677822;5860.033094539353 04:08:15 INFO - PROCESS | 11992 | |1;ext.html;576.3285772075532;621.3817251834424;648.0667838312829;659.3208994735418;677.2989955396166;34302.828485857564;45022.32466513005;45934.0813183737;46018.53981460184;46050.76974615131;46407.535924640826;46779.298310525366;46876;46914;46917.53082469174;8297.626606802678;8847.77880552985;8995.370324077317;8997.190252877239;8998.370114092017;8343.791405214888;10534.473276336152;10759.300645458059;10786.298890572127;10987.670369888916;10829;10876.075533579615;10907.072898803612;10919.890801092006;10926.836097458545;10642.308249963728;10683;10703.197260205516;10710.732231694192;10723.946380268128;10709.946450267698;10758.408287544182;10759.246852720313;10760.139188864872;10761.623343182951;42637;42874.571254287366;42887.35668964968;42893.785531072455;42960.14079718388;3582.4805403216646;3638.399664055428;3641.453781932731;3668.064643515913;3677.5770786359376;32862.83568582142;32925;33144;33267.500987485204;33268.50097248519;4459.799309031101;4535.591796738309;4537.500874903758;4562.58936695699;4579.473360563545;358748;360164;361045;361491;364099;60396.88610898597;60797.39202608006;60822.087668685;60871.391286086575;60910.69544652337;39655.80172099179;40497.59502404997;40775;42807;42838.78580607139;17357.218925148398;17467.912660436872;17478.82521174772;17495.387661432043;17505.12474376276;13249.801252981213;13705.109167904055;14126.576202713935;14538.709225815424;14747.336369863382;19566.119524621427;19949.900250498653;20016.799832001783;20089.196432142842;20319;7097.432205423554;7263.854722905512;7338.963305183546;7371.741989030358;7499;1041.4480325427535;1056.3397876327294;1076.2681376663786;1079.0881704959297;1138.5901075612774;33568.83215583907;33639;33755.324893501995;33799.32401351959;33873;1045.7529371302148;1104.3484344236938;1152.991132758836;1167.2821214952744;1167.7255844876447;15142.621434464227;17931.614627146373;18579.349722759907;18599.90700046491;18710.438686839418;507194;508766;510817;512220;512938;60154.69922650359;60654.39345606576;60669.69665151646;60727;60806.69596651988;1347.6765576261625;1377.9931100344634;1397.0290647999543;1403.333416627094;1434.8995570309978;30396.124479177015;31998;32063.839680801448;32144.761563034397;32358.83820580882;51575.48424515857;51668.48331516787;51957.48042519527;52111.218331724296;52122.73938630283;332662;333955;333970;333994;335156;27213.72786272112;29691.85154074216;29901.401971960873;31540.526892097096;31696;47815.521844782495;48703.26945095755;48773;48880;49897.50102498929;40642.1871562573;40661.39007914943;43432.131357373306;43942;44705;42482.36276455918;43454.13091738211;43628.12743745171;43663.34504982364;44014.779926100164;43725;44377;44783.77608111939;44827.551724483645;44848.32727509025;35808.46287305745;37664.43503347507;37942.43086353762;38043.80978095092;38206;28788.712112879442;28841.827398986516;29082.27294317659;29145.562816557343;29226.56160157557 04:08:15 INFO - PROCESS | 11992 | |2;jquery.html;419.2202503343782;420.1617772543774;423.5679606801062;428.55644408037676;445.40093574142765;18203.18085686144;19429.805701942976;20133;20154.798452015475;20439.080241389136;16513.91743041286;17753.28986840525;19436.22255109794;19893.701594476093;19926.003699814988;5410;5820.767169313222;5846.824595262149;5852.209951656536;5853.531717462614;5584.134459158837;5781.566382521307;5788.6237394569425;5846.298444186704;5848.619839710405;5679.971600141994;5707.77168913243;5717.142428635696;5721.656700597978;5725.656460612356;5509.504144626962;5707.914381284263;5711.8000869969555;5714.771409143608;5718.085106382959;5191.091558977164;5193.506616871391;5198.16829307309;5205.531502164786;5206.5314121729225;23021.654675179885;23068.53862922732;23078.307650770505;23080.076796928104;23291.767082329297;2455.987720061406;2496.213692686798;2508.761667641571;2523.7854782343525;2533.518631460017;14061.296935153303;14311.069780464237;14410.567682969528;14822.851771482363;15316;1969.7045443183495;2026.432598872318;2044.2231951858348;2060.1862264405477;2131.5097527568746;77300.99999999943;92563.53718231434;99277.50361248148;99382;101042;16688.91655541739;17587;17765;17896.373626922996;18586.163622637014;29319.267018324714;29371;30588.847055764578;32852.835735821165;33131.3373732524;9996.700098997042;10077;10094.747631309128;10165.745856353502;10282.228832837418;8319;8417.116202798741;8449.788755281044;8632.741017769476;8688.95655521731;8898.154675305836;9108.544572771334;9171.266298696088;9240.306976976754;9263.444193348421;3525.823708814549;3537.239493508908;3565.322588708189;3581.463828512922;3615.2769446110883;972.8832540095234;1018.1345856022322;1041.578160844859;1077.7605753383514;1091.7980173667897;19502.609947800964;19739.703904441445;19907.502312442306;20023.399298021082;20272.695909561367;1004.4977511244377;1007.6473234368059;1009.65671671632;1068.529846867376;1076.8169411200115;10201.591936322464;10871.782564348669;10919;10995.945020275007;11012;492009;494806;530719;559466;561472;85005;88824;89241.55379223062;89370.55314723385;90592.54703726439;997.2072202598952;1047.7433028907967;1058.714147180257;1072.1958531101673;1076.1337123615408;16705.16474176262;16896.23966921467;17485.21316540733;17503.912480437517;17856.107194640477;31997.16211422505;35355;41168.38247426351;42244.577554224066;43381.34927976146;53257.4674253268;58007.419925800205;58025.70987145037;58707;60427.395726042174;8678.566071696516;8860.424072435271;8881.067487913677;8909.55452227399;9002.909970900208;12387.75224495487;12525.248485090924;12882.227066376048;12927.224366538037;12936.482540698267;11049.83425248638;11351.318920864775;11475.254108482923;11836.70408239801;12157.817632735692;11183.329000259684;11691.298522088702;12193.695157620776;12208.267503949792;12772.74454510886;11765.294082355085;11815;12118.878811211775;12189.69525761863;12255.938720306342;7749.341305988829;8177.877331839908;8235.794105147419;8913.509756963429;9307.488088155216;9343;12005.63983080509;12168.75662486763;12282.07884408655;12697.55558555446 04:08:15 INFO - PROCESS | 11992 | |3;mootools.html;1453.2878889344217;1481.11133320008;1615.6445581971961;1764.126757255159;1826.0504537640436;8180.181981801817;8760.16778406052;8773.429727067753;8779;8779.4732316061;7394.37147842434;7564.962175189116;7940.245676660722;8083.47457415269;8617.13828617138;2447.559439300925;2477.2320580619976;2478.281298423455;2478.7521247875247;2483.838550494221;2454.6808914841044;2517.9748202518017;2518.5718427867214;2521.382261345973;2523.6971563412417;2466.1861585676775;2467.5558399488086;2487.577111890974;2488.365466805971;2488.701355837302;2413.1553956115395;2414.215380001489;2414.3360575841784;2422.63660450932;2449.6815413996155;2405.579023670868;2412.0592968742203;2427.8421902576274;2434.549608322466;2436.305652888936;8229.382796290301;8234.176582341717;8257.504549726975;8280.544570048645;8293.709720159766;5324.653897496651;5472.1244600864065;5485.780568777244;5493;5493.2034854945805;3510.78935263885;3589.958911915541;3614.313280476701;3619.89140325788;3691.9446208306895;1185.6028230542693;1197.1440420099584;1201.645514573203;1252.2549083295426;1288.465286905933;11514.194006419553;11547.769044619145;11572.942135289353;11590.362530060844;11623.360715160663;4707.815747498617;4743.051389722069;4746.786394612251;4819.975900120477;4878.195097808822;10116.898831011742;10124.54439550222;10131.392116472887;10131.949340253399;10132.290739648153;5339.46605339463;5352.946470535245;5355.919661205085;5368.865778355573;5370.516653501126;4397.296432570837;4507.301368287921;4855.32025516428;4872.561469467765;4912.9508704913205;3936.4685767421606;4074.8573799916862;4093.570175131628;4145.0880806222585;4159.209750147523;1359.789232668938;1362.611655678127;1366.6310096274149;1372.6568357910523;1378.2970684950747;889.3107841422819;977.1108291454884;979.6718099436627;988.0909563201872;989.5942663507927;5558.471945165203;5568.582356323211;5778.7688492460675;5886.381929897385;5919.496842768327;970.4856426094182;992.846108853129;1038.1383451735041;1070.8500809886623;1099.6755956992706;3800.8669696560487;4014.979925100356;4036.899077523027;4042.6361627453084;4159.729617574848;10340.741481463023;10366.170706343475;10440.112590429899;10465.633702820365;10747.30142540748;9922.305438619227;10120.544575494121;10172.847407288897;10251.231157663056;10383.480825958823;7927.326177274997;8125;8154.551499667576;8206.876896846552;8217.096119426858;5503.7798488060025;5568.97215513936;5657.236273103078;5726.627769194989;5833.095870139965;9145.359824812465;9334.113259240361;9400.623975041195;9478.763030924281;9594;8803.163699448542;9073.228775554151;9104.408213466104;9440.19758320523;9507.191888689262;7185.820354491179;7513.39892808585;7853.253940875607;8281.54451505173;8419.957900210704;8246.876296855671;8559.529225892637;8592;8597.8710319344;8609;7488.475806693479;7596.468247222641;7622.733204337822;7657.272559106876;7823.413244006609;7304.96347518259;7364.226756190523;7515.699372025277;7544.924550754642;7555.320021198118;6800.52396332252;6886.380225779503;6890.035395044598;6894.931050689429;6907.620080895398;5058.898822023612;5082.872928176826;5124.513171248875;5142.460041695717;5323.30796996388;4979.950200497949;5010.198368261206;5092.898142037213;5161.380634323905;5282.683039017671 04:08:15 INFO - PROCESS | 11992 | |4;prototype.html;339.8555613864107;344.28904312594506;346.9496922946173;348.6948919695267;350.7920070951152;5398.811041613544;5434.972825135868;5442.455754424555;5450.781968721251;5482.369527504328;5154.381474223089;5204.193350030751;5278.6568873023225;5284.365876094865;5432.429594892538;4207.600277973587;4224.61978421942;4239.198340705196;4244.363345498185;4260.744355338674;4210.473690788652;4222.627646015042;4234.703570750049;4247.15056988602;4286.549912259199;3958.2083583283315;3999.560048394674;4163.958360416387;4208.410822484854;4237.491501019882;4163.3130533461945;4164.895877603084;4172.165566886604;4183.3097538906195;4190.497140343148;3744.4383342498572;3748.5314335708035;3749.775013499199;3759.4360845873066;3766.472693822867;5091.134507133796;5208.088584497736;5220.765065572058;5261.631685781997;5261.842144735626;4838.661293709407;4855.805767769285;4863.781129849165;4877.146499362633;4882.707037577757;5603.8879222415735;5604.271444712162;5612.943870561283;5625.212470254168;5626.115251390789;4071.89820254496;4101.6540213955905;4112.157007813421;4145.564715704838;4160.687948403852;5797.913031304533;5804.100364443518;5811.041178205591;5820.417958204146;5831.620944638627;4245.681573881971;4248.787560622019;4250.639795265547;4251.128518653669;4289.420928174719;4234.978825105854;4248.214080395137;4291.935620965688;4345.587169218919;4347.5217726050105;4826.734529600905;4830.3237546743485;4831.855044348676;4836.733979631154;4860.684055536379;5630.577706672016;5633.732410207753;5638.9436105638415;5641.435856414326;5647.604667673223;1392.3386391464176;1436.727021865842;1441.889744896424;1441.9495317663832;1452.678062962699;954.7613096725819;965.7875267441152;1006;1030.9123724483352;1031.2729525684374;5231.293775340357;5256.842294731164;5284.497972692588;5316.76074576645;5329.893402132013;5541.833744987657;5554.500474786362;5601.915971260434;5607.383187849333;5646.830595082154;5153.407358153785;5247.763850626731;5285.709285989231;5312.973435132877;5330.307060082165;2892.944075412501;2894.653985896526;2917.139443864065;2922.473954688134;2925.297928497145;5539.335279766454;5708.372079071299;5714.685622306893;5721.6554109784165;5757.416710404672;5571.804986825442;5574.303212098488;5575.832725018256;5596.608237423341;5605.607607467438;5667.631603945731;5691.231683722644;5703.743331550173;5716.997152989427;5720.570957178228;5290.365156181283;5517.944310931382;5523.226748255167;5566.638168519034;5567.494627417759;5443.428440013741;5466.480684334982;5479.643823151482;5498.257735205696;5520.779168833202;5424.430434804446;5693.658380497183;5712.5429965601825;5722.6852523109965;5763.827085187451;4079.204555111725;4086.8773936781945;4097.893568736365;4103.076807718239;4106.733062350938;5450.836474905759;5488.945110548843;5522.806701765419;5537.141743029837;5550.361708403424;5417.539509141609;5434.592405569677;5435.945640543702;5447;5448.645838020516;5618.971905140448;5620.971895140498;5631.802886898939;5663.688497132697;5673.319201695823;5407.891842163213;5561.693002144412;5627.577931655061;5653.830385088454;5666.9716651416475;5557.44425557441;5666.17840413146;5723.02708539541;5734.455226753452;5742.59801813869;5562.4993750561025;5573.470520300565;5587.329520457409;5588.497035266845;5597.888042239214 04:08:15 INFO - PROCESS | 11992 | |5;yui.html;728.533738407419;752.1650967426156;795.614127148333;797.7806103321584;832.4921797703396;15034.548963531099;15970.680586388266;15994.76007859883;16011.27949242284;16019.759703604455;14649.560513184595;14821;14832.55502334929;14835.406583736638;14836.777448338256;709.5707097206193;732.3811379384438;823.3660081737058;850.0819115355432;850.3664769746532;848.6053984897021;848.719922425598;855.7347222361057;858.1847245117133;866.7009881590841;893.0399820193286;899.6356475627381;901.364538000708;902.1024081039375;903.5933829776594;749.3143773447289;886.4016788667624;886.778305423644;887.9378443508957;888.6134531478795;560.0758748065683;632.2665707778955;648.1315037849257;654.2574178307608;657.6810247030187;14672.239331280314;14762.335694893649;14772.335244914004;14795.630109247248;14863.628409289746;13752.724945501133;14034.508792192326;14194.92902535491;14223.786643200257;14263;12044.759104817855;12216.816747748791;12303.569375071918;12317.630471085882;12354.938225308906;3912.1979994101425;3949.624785645388;3950.7036972227197;3979.064919743858;4055.330870406409;66881.331186688;66975.66512167409;67310.3268967309;69156.6542167291;69745.99999999949;10998;11147.275427097213;11427.48576314068;11530.481128349244;11695.181337306307;20186;20394;20407.795922040885;20456.386308410772;20669.17323307081;8260.586970651444;8360.372972027;8456.323494120456;8584.699535516227;8853.911460885438;4421.845235416745;4566.406367172246;4842.95157048425;4849.199882019428;4943.826966056243;3349.0120414477788;3402.9489557656657;3430.9313813723584;3435.3301106284534;3444.328355970612;577.3245302995506;579.2643342954508;583.4981915552621;591.8283697727696;595.8867815115115;617.4566381584177;633.2907143998751;675.2032601530143;687.6046273392819;709.8331892005375;8965.596548155349;9533.618655253851;9538.809223815484;9571.61713531465;9703.6118555257;620.314552419579;687.285223367692;690.7133539581017;690.944724422045;706.3254591864757;4552.817887284537;4710.599599034121;4737.478877323491;4829.27560865873;4856.781444834991;89529;89829.30512084517;93857;94415.52792236132;97145.51427242819;81610.59194703988;82516.58741706373;82612.58693706493;82814;85483.5725821367;73679.63160184165;75674;76781.6160919203;77127.61436192783;77755.61122194353;9709.90635241936;10250.538725757508;10412.427316497666;10604.204684648528;10725.839112413163;35752.64247357493;45697.60479041916;45808;48572;50708.74645626748;55813.441865580826;56765.43234567602;59401.405985939586;63148;65211.347886520525;12739.490420383452;12814.295213763333;12833.358332083546;13056.412461439448;13237.867621324049;14043.578692639237;14503.492377766728;14618.780718289021;15048.699026019638;15340.693186135992;13720.86279137196;13879.375428105557;14105.647358816112;14333.928330358282;14550.636234094232;13573.253471059186;13723.245221512514;13955.651108721957;14643.41426342977;14662;13757.899368050732;13926.234057126956;13961.371738272006;14500.637484062561;14536.781948270997;11338.376389298668;11744.823827642764;11838.70215100218;12049.819252711392;12417.94447471975;11647.6505704829;12021.819672704742;12022.087299802823;12039.699007524881;12207.206531575419 04:08:15 INFO - PROCESS | 11992 | __end_tp_report 04:08:15 INFO - PROCESS | 11992 | __start_cc_report 04:08:15 INFO - PROCESS | 11992 | _x_x_mozilla_cycle_collect,1045 04:08:15 INFO - PROCESS | 11992 | __end_cc_report 04:08:15 INFO - PROCESS | 11992 | __startTimestamp1479470895050__endTimestamp 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | ------- Summary: start ------- 04:08:15 INFO - PROCESS | 11992 | Number of tests: 6 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#0] dojo.html Cycles:165 Average:5599.80 Median:5802.65 stddev:639.80 (11.0%) stddev-sans-first:613.64 04:08:15 INFO - PROCESS | 11992 | Values: 3208.4 3253.8 3268.4 3271.9 3289.6 5614.3 5651.8 5653.2 5673.5 5696.2 5598.8 5654.2 5657.1 5667.1 5680.3 5073.5 5085.3 5104.4 5142.0 5160.7 4968.4 4984.3 5186.2 5186.4 5190.9 5058.0 5075.7 5104.2 5117.3 5141.8 5135.9 5195.0 5199.9 5202.6 5221.6 4902.3 5109.3 5136.2 5164.5 5193.4 5464.5 5479.1 5481.4 5506.9 5539.3 5925.7 5958.7 6012.5 6027.7 6037.2 5867.5 6088.1 6099.1 6100.6 6100.9 5522.6 5583.1 5696.9 5704.0 5705.5 6243.0 6250.6 6250.8 6251.1 6261.7 5802.7 5984.1 6003.2 6006.7 6011.7 5928.4 5929.1 5989.8 6004.6 6058.3 5982.2 5996.3 5999.2 6003.4 6034.2 5960.0 6001.0 6010.5 6020.2 6020.7 4515.5 4577.7 4582.5 4623.1 4646.9 4115.3 4157.8 4161.9 4170.5 4172.9 5781.9 5784.4 5794.5 5796.5 5800.0 5881.4 5899.0 5938.6 5979.2 6082.5 5666.9 5668.9 5672.5 5678.8 5701.7 5114.5 5123.1 5127.2 5132.2 5139.8 6017.8 6114.8 6148.4 6201.1 6220.5 5993.8 6087.9 6092.9 6131.3 6133.9 6296.7 6299.6 6324.6 6336.0 6343.1 5794.5 5801.7 5971.1 5973.9 5976.6 5937.9 6024.1 6025.1 6092.8 6103.7 5912.9 5947.4 5957.1 5964.9 5970.9 5668.3 5907.0 5922.0 5930.4 5935.2 5769.4 5832.2 5896.5 5897.2 5969.5 5975.9 5993.4 6006.2 6011.5 6013.8 5661.4 5680.2 5717.3 5852.6 5860.0 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#1] ext.html Cycles:180 Average:57450.30 Median:182564.70 stddev:108007.25 (59.2%) stddev-sans-first:108225.82 04:08:15 INFO - PROCESS | 11992 | Values: 576.3 621.4 648.1 659.3 677.3 34302.8 45022.3 45934.1 46018.5 46050.8 46407.5 46779.3 46876.0 46914.0 46917.5 8297.6 8847.8 8995.4 8997.2 8998.4 8343.8 10534.5 10759.3 10786.3 10987.7 10829.0 10876.1 10907.1 10919.9 10926.8 10642.3 10683.0 10703.2 10710.7 10723.9 10709.9 10758.4 10759.2 10760.1 10761.6 42637.0 42874.6 42887.4 42893.8 42960.1 3582.5 3638.4 3641.5 3668.1 3677.6 32862.8 32925.0 33144.0 33267.5 33268.5 4459.8 4535.6 4537.5 4562.6 4579.5 358748.0 360164.0 361045.0 361491.0 364099.0 60396.9 60797.4 60822.1 60871.4 60910.7 39655.8 40497.6 40775.0 42807.0 42838.8 17357.2 17467.9 17478.8 17495.4 17505.1 13249.8 13705.1 14126.6 14538.7 14747.3 19566.1 19949.9 20016.8 20089.2 20319.0 7097.4 7263.9 7339.0 7371.7 7499.0 1041.4 1056.3 1076.3 1079.1 1138.6 33568.8 33639.0 33755.3 33799.3 33873.0 1045.8 1104.3 1153.0 1167.3 1167.7 15142.6 17931.6 18579.3 18599.9 18710.4 507194.0 508766.0 510817.0 512220.0 512938.0 60154.7 60654.4 60669.7 60727.0 60806.7 1347.7 1378.0 1397.0 1403.3 1434.9 30396.1 31998.0 32063.8 32144.8 32358.8 51575.5 51668.5 51957.5 52111.2 52122.7 332662.0 333955.0 333970.0 333994.0 335156.0 27213.7 29691.9 29901.4 31540.5 31696.0 47815.5 48703.3 48773.0 48880.0 49897.5 40642.2 40661.4 43432.1 43942.0 44705.0 42482.4 43454.1 43628.1 43663.3 44014.8 43725.0 44377.0 44783.8 44827.6 44848.3 35808.5 37664.4 37942.4 38043.8 38206.0 28788.7 28841.8 29082.3 29145.6 29226.6 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#2] jquery.html Cycles:180 Average:31234.93 Median:2528.65 stddev:86964.72 (3439.2%) stddev-sans-first:87177.89 04:08:15 INFO - PROCESS | 11992 | Values: 419.2 420.2 423.6 428.6 445.4 18203.2 19429.8 20133.0 20154.8 20439.1 16513.9 17753.3 19436.2 19893.7 19926.0 5410.0 5820.8 5846.8 5852.2 5853.5 5584.1 5781.6 5788.6 5846.3 5848.6 5680.0 5707.8 5717.1 5721.7 5725.7 5509.5 5707.9 5711.8 5714.8 5718.1 5191.1 5193.5 5198.2 5205.5 5206.5 23021.7 23068.5 23078.3 23080.1 23291.8 2456.0 2496.2 2508.8 2523.8 2533.5 14061.3 14311.1 14410.6 14822.9 15316.0 1969.7 2026.4 2044.2 2060.2 2131.5 77301.0 92563.5 99277.5 99382.0 101042.0 16688.9 17587.0 17765.0 17896.4 18586.2 29319.3 29371.0 30588.8 32852.8 33131.3 9996.7 10077.0 10094.7 10165.7 10282.2 8319.0 8417.1 8449.8 8632.7 8689.0 8898.2 9108.5 9171.3 9240.3 9263.4 3525.8 3537.2 3565.3 3581.5 3615.3 972.9 1018.1 1041.6 1077.8 1091.8 19502.6 19739.7 19907.5 20023.4 20272.7 1004.5 1007.6 1009.7 1068.5 1076.8 10201.6 10871.8 10919.0 10995.9 11012.0 492009.0 494806.0 530719.0 559466.0 561472.0 85005.0 88824.0 89241.6 89370.6 90592.5 997.2 1047.7 1058.7 1072.2 1076.1 16705.2 16896.2 17485.2 17503.9 17856.1 31997.2 35355.0 41168.4 42244.6 43381.3 53257.5 58007.4 58025.7 58707.0 60427.4 8678.6 8860.4 8881.1 8909.6 9002.9 12387.8 12525.2 12882.2 12927.2 12936.5 11049.8 11351.3 11475.3 11836.7 12157.8 11183.3 11691.3 12193.7 12208.3 12772.7 11765.3 11815.0 12118.9 12189.7 12255.9 7749.3 8177.9 8235.8 8913.5 9307.5 9343.0 12005.6 12168.8 12282.1 12697.6 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#3] mootools.html Cycles:180 Average:5677.61 Median:5087.89 stddev:3058.16 (60.1%) stddev-sans-first:3050.26 04:08:15 INFO - PROCESS | 11992 | Values: 1453.3 1481.1 1615.6 1764.1 1826.1 8180.2 8760.2 8773.4 8779.0 8779.5 7394.4 7565.0 7940.2 8083.5 8617.1 2447.6 2477.2 2478.3 2478.8 2483.8 2454.7 2518.0 2518.6 2521.4 2523.7 2466.2 2467.6 2487.6 2488.4 2488.7 2413.2 2414.2 2414.3 2422.6 2449.7 2405.6 2412.1 2427.8 2434.5 2436.3 8229.4 8234.2 8257.5 8280.5 8293.7 5324.7 5472.1 5485.8 5493.0 5493.2 3510.8 3590.0 3614.3 3619.9 3691.9 1185.6 1197.1 1201.6 1252.3 1288.5 11514.2 11547.8 11572.9 11590.4 11623.4 4707.8 4743.1 4746.8 4820.0 4878.2 10116.9 10124.5 10131.4 10131.9 10132.3 5339.5 5352.9 5355.9 5368.9 5370.5 4397.3 4507.3 4855.3 4872.6 4913.0 3936.5 4074.9 4093.6 4145.1 4159.2 1359.8 1362.6 1366.6 1372.7 1378.3 889.3 977.1 979.7 988.1 989.6 5558.5 5568.6 5778.8 5886.4 5919.5 970.5 992.8 1038.1 1070.9 1099.7 3800.9 4015.0 4036.9 4042.6 4159.7 10340.7 10366.2 10440.1 10465.6 10747.3 9922.3 10120.5 10172.8 10251.2 10383.5 7927.3 8125.0 8154.6 8206.9 8217.1 5503.8 5569.0 5657.2 5726.6 5833.1 9145.4 9334.1 9400.6 9478.8 9594.0 8803.2 9073.2 9104.4 9440.2 9507.2 7185.8 7513.4 7853.3 8281.5 8420.0 8246.9 8559.5 8592.0 8597.9 8609.0 7488.5 7596.5 7622.7 7657.3 7823.4 7305.0 7364.2 7515.7 7544.9 7555.3 6800.5 6886.4 6890.0 6894.9 6907.6 5058.9 5082.9 5124.5 5142.5 5323.3 4980.0 5010.2 5092.9 5161.4 5282.7 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#4] prototype.html Cycles:180 Average:4690.22 Median:5323.33 stddev:1345.01 (25.3%) stddev-sans-first:1308.55 04:08:15 INFO - PROCESS | 11992 | Values: 339.9 344.3 346.9 348.7 350.8 5398.8 5435.0 5442.5 5450.8 5482.4 5154.4 5204.2 5278.7 5284.4 5432.4 4207.6 4224.6 4239.2 4244.4 4260.7 4210.5 4222.6 4234.7 4247.2 4286.5 3958.2 3999.6 4164.0 4208.4 4237.5 4163.3 4164.9 4172.2 4183.3 4190.5 3744.4 3748.5 3749.8 3759.4 3766.5 5091.1 5208.1 5220.8 5261.6 5261.8 4838.7 4855.8 4863.8 4877.1 4882.7 5603.9 5604.3 5612.9 5625.2 5626.1 4071.9 4101.7 4112.2 4145.6 4160.7 5797.9 5804.1 5811.0 5820.4 5831.6 4245.7 4248.8 4250.6 4251.1 4289.4 4235.0 4248.2 4291.9 4345.6 4347.5 4826.7 4830.3 4831.9 4836.7 4860.7 5630.6 5633.7 5638.9 5641.4 5647.6 1392.3 1436.7 1441.9 1441.9 1452.7 954.8 965.8 1006.0 1030.9 1031.3 5231.3 5256.8 5284.5 5316.8 5329.9 5541.8 5554.5 5601.9 5607.4 5646.8 5153.4 5247.8 5285.7 5313.0 5330.3 2892.9 2894.7 2917.1 2922.5 2925.3 5539.3 5708.4 5714.7 5721.7 5757.4 5571.8 5574.3 5575.8 5596.6 5605.6 5667.6 5691.2 5703.7 5717.0 5720.6 5290.4 5517.9 5523.2 5566.6 5567.5 5443.4 5466.5 5479.6 5498.3 5520.8 5424.4 5693.7 5712.5 5722.7 5763.8 4079.2 4086.9 4097.9 4103.1 4106.7 5450.8 5488.9 5522.8 5537.1 5550.4 5417.5 5434.6 5435.9 5447.0 5448.6 5619.0 5621.0 5631.8 5663.7 5673.3 5407.9 5561.7 5627.6 5653.8 5667.0 5557.4 5666.2 5723.0 5734.5 5742.6 5562.5 5573.5 5587.3 5588.5 5597.9 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - PROCESS | 11992 | [#5] yui.html Cycles:180 Average:18745.38 Median:4724.04 stddev:24915.40 (527.4%) stddev-sans-first:24948.57 04:08:15 INFO - PROCESS | 11992 | Values: 728.5 752.2 795.6 797.8 832.5 15034.5 15970.7 15994.8 16011.3 16019.8 14649.6 14821.0 14832.6 14835.4 14836.8 709.6 732.4 823.4 850.1 850.4 848.6 848.7 855.7 858.2 866.7 893.0 899.6 901.4 902.1 903.6 749.3 886.4 886.8 887.9 888.6 560.1 632.3 648.1 654.3 657.7 14672.2 14762.3 14772.3 14795.6 14863.6 13752.7 14034.5 14194.9 14223.8 14263.0 12044.8 12216.8 12303.6 12317.6 12354.9 3912.2 3949.6 3950.7 3979.1 4055.3 66881.3 66975.7 67310.3 69156.7 69746.0 10998.0 11147.3 11427.5 11530.5 11695.2 20186.0 20394.0 20407.8 20456.4 20669.2 8260.6 8360.4 8456.3 8584.7 8853.9 4421.8 4566.4 4843.0 4849.2 4943.8 3349.0 3402.9 3430.9 3435.3 3444.3 577.3 579.3 583.5 591.8 595.9 617.5 633.3 675.2 687.6 709.8 8965.6 9533.6 9538.8 9571.6 9703.6 620.3 687.3 690.7 690.9 706.3 4552.8 4710.6 4737.5 4829.3 4856.8 89529.0 89829.3 93857.0 94415.5 97145.5 81610.6 82516.6 82612.6 82814.0 85483.6 73679.6 75674.0 76781.6 77127.6 77755.6 9709.9 10250.5 10412.4 10604.2 10725.8 35752.6 45697.6 45808.0 48572.0 50708.7 55813.4 56765.4 59401.4 63148.0 65211.3 12739.5 12814.3 12833.4 13056.4 13237.9 14043.6 14503.5 14618.8 15048.7 15340.7 13720.9 13879.4 14105.6 14333.9 14550.6 13573.3 13723.2 13955.7 14643.4 14662.0 13757.9 13926.2 13961.4 14500.6 14536.8 11338.4 11744.8 11838.7 12049.8 12417.9 11647.7 12021.8 12022.1 12039.7 12207.2 04:08:15 INFO - PROCESS | 11992 | -------- Summary: end -------- 04:08:15 INFO - PROCESS | 11992 | 04:08:15 INFO - TEST-INFO | 11992: exit 0 04:08:15 INFO - TEST-OK | dromaeo_css | took 1115576ms 04:08:15 INFO - TEST-START | kraken 04:08:15 INFO - operating with platform_type : linux_ 04:08:15 INFO - Initialising browser for kraken test... 04:08:15 INFO - TEST-INFO | started process 12308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMHegL/profile http://localhost:42672/getInfo.html) 04:08:18 ERROR - PROCESS | 12308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 04:08:19 INFO - PROCESS | 12308 | __metrics Screen width/height:1600/1200 04:08:19 INFO - PROCESS | 12308 | colorDepth:24 04:08:19 INFO - PROCESS | 12308 | Browser inner width/height: 1024/697 04:08:19 INFO - PROCESS | 12308 | __metrics 04:08:20 INFO - PROCESS | 12308 | 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" 04:08:20 INFO - PROCESS | 12308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:20 INFO - PROCESS | 12308 | console.error: PushService: 04:08:20 INFO - PROCESS | 12308 | stateChangeProcessEnqueue: Error transitioning state 04:08:20 INFO - PROCESS | 12308 | UnknownError 04:08:21 INFO - TEST-INFO | 12308: exit 0 04:08:21 INFO - Browser initialized. 04:08:21 INFO - Running cycle 1/1 for kraken test... 04:08:21 INFO - TEST-INFO | started process 12405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMHegL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:33 INFO - PROCESS | 12405 | RSS: Main: 144273408 04:08:33 INFO - PROCESS | 12405 | 04:08:35 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42672/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:36 INFO - PROCESS | 12405 | RSS: Main: 185131008 04:08:36 INFO - PROCESS | 12405 | 04:08:38 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42672/tests/kraken/driver.html?testName=audio-dft) 04:08:39 INFO - PROCESS | 12405 | RSS: Main: 175996928 04:08:39 INFO - PROCESS | 12405 | 04:08:42 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42672/tests/kraken/driver.html?testName=audio-fft) 04:08:42 INFO - PROCESS | 12405 | RSS: Main: 266637312 04:08:42 INFO - PROCESS | 12405 | 04:08:45 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42672/tests/kraken/driver.html?testName=audio-oscillator) 04:08:45 INFO - PROCESS | 12405 | RSS: Main: 173264896 04:08:45 INFO - PROCESS | 12405 | 04:08:47 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:48 INFO - PROCESS | 12405 | RSS: Main: 175632384 04:08:48 INFO - PROCESS | 12405 | 04:08:51 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42672/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:51 INFO - PROCESS | 12405 | RSS: Main: 214585344 04:08:51 INFO - PROCESS | 12405 | 04:08:55 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42672/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:55 INFO - PROCESS | 12405 | RSS: Main: 212914176 04:08:55 INFO - PROCESS | 12405 | 04:08:58 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42672/tests/kraken/driver.html?testName=json-parse-financial) 04:08:59 INFO - PROCESS | 12405 | RSS: Main: 211537920 04:08:59 INFO - PROCESS | 12405 | 04:09:00 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:01 INFO - PROCESS | 12405 | RSS: Main: 174133248 04:09:01 INFO - PROCESS | 12405 | 04:09:02 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:03 INFO - PROCESS | 12405 | RSS: Main: 181239808 04:09:03 INFO - PROCESS | 12405 | 04:09:05 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:05 INFO - PROCESS | 12405 | RSS: Main: 190816256 04:09:05 INFO - PROCESS | 12405 | 04:09:08 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:09 INFO - PROCESS | 12405 | RSS: Main: 198791168 04:09:09 INFO - PROCESS | 12405 | 04:09:11 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:12 INFO - PROCESS | 12405 | RSS: Main: 195194880 04:09:12 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | Cycle 1(1): loaded http://localhost:42672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42672/tests/kraken/driver.html?testName=ai-astar) 04:09:14 INFO - PROCESS | 12405 | RSS: Main: 246288384 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | __start_tp_report 04:09:14 INFO - PROCESS | 12405 | _x_x_mozilla_page_load 04:09:14 INFO - PROCESS | 12405 | _x_x_mozilla_page_load_details 04:09:14 INFO - PROCESS | 12405 | |i|pagename|runs| 04:09:14 INFO - PROCESS | 12405 | |0;ai-astar;102;113;111;110;110;112;112;111;112;111 04:09:14 INFO - PROCESS | 12405 | |1;audio-beat-detection;154;125;123;154;128;123;123;124;147;122 04:09:14 INFO - PROCESS | 12405 | |2;audio-dft;162;160;160;161;161;163;160;162;158;158 04:09:14 INFO - PROCESS | 12405 | |3;audio-fft;84;75;76;101;75;75;76;76;96;74 04:09:14 INFO - PROCESS | 12405 | |4;audio-oscillator;82;82;110;84;82;81;103;82;82;110 04:09:14 INFO - PROCESS | 12405 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;116;116 04:09:14 INFO - PROCESS | 12405 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;148;145 04:09:14 INFO - PROCESS | 12405 | |7;imaging-desaturate;84;84;84;85;85;84;85;85;84;84 04:09:14 INFO - PROCESS | 12405 | |8;json-parse-financial;49;49;51;50;50;49;51;51;49;51 04:09:14 INFO - PROCESS | 12405 | |9;json-stringify-tinderbox;60;60;60;59;61;60;59;63;59;63 04:09:14 INFO - PROCESS | 12405 | |10;stanford-crypto-aes;75;75;81;77;75;75;81;74;75;73 04:09:14 INFO - PROCESS | 12405 | |11;stanford-crypto-ccm;129;135;128;129;127;126;127;134;179;131 04:09:14 INFO - PROCESS | 12405 | |12;stanford-crypto-pbkdf2;159;155;151;154;155;154;155;155;154;155 04:09:14 INFO - PROCESS | 12405 | |13;stanford-crypto-sha256-iterative;62;62;62;64;66;61;62;61;61;60 04:09:14 INFO - PROCESS | 12405 | __end_tp_report 04:09:14 INFO - PROCESS | 12405 | __start_cc_report 04:09:14 INFO - PROCESS | 12405 | _x_x_mozilla_cycle_collect,1636 04:09:14 INFO - PROCESS | 12405 | __end_cc_report 04:09:14 INFO - PROCESS | 12405 | __startTimestamp1479470954438__endTimestamp 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | ------- Summary: start ------- 04:09:14 INFO - PROCESS | 12405 | Number of tests: 14 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 04:09:14 INFO - PROCESS | 12405 | Values: 102.0 113.0 111.0 110.0 110.0 112.0 112.0 111.0 112.0 111.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:126.50 stddev:13.60 (10.7%) stddev-sans-first:11.94 04:09:14 INFO - PROCESS | 12405 | Values: 154.0 125.0 123.0 154.0 128.0 123.0 123.0 124.0 147.0 122.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.65 (1.0%) stddev-sans-first:1.66 04:09:14 INFO - PROCESS | 12405 | Values: 162.0 160.0 160.0 161.0 161.0 163.0 160.0 162.0 158.0 158.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:9.81 (12.9%) stddev-sans-first:10.33 04:09:14 INFO - PROCESS | 12405 | Values: 84.0 75.0 76.0 101.0 75.0 75.0 76.0 76.0 96.0 74.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:12.50 (15.2%) stddev-sans-first:12.93 04:09:14 INFO - PROCESS | 12405 | Values: 82.0 82.0 110.0 84.0 82.0 81.0 103.0 82.0 82.0 110.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:09:14 INFO - PROCESS | 12405 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:09:14 INFO - PROCESS | 12405 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 148.0 145.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 04:09:14 INFO - PROCESS | 12405 | Values: 84.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.50 stddev:0.94 (1.9%) stddev-sans-first:0.93 04:09:14 INFO - PROCESS | 12405 | Values: 49.0 49.0 51.0 50.0 50.0 49.0 51.0 51.0 49.0 51.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.51 (2.5%) stddev-sans-first:1.59 04:09:14 INFO - PROCESS | 12405 | Values: 60.0 60.0 60.0 59.0 61.0 60.0 59.0 63.0 59.0 63.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:2.77 (3.7%) stddev-sans-first:2.91 04:09:14 INFO - PROCESS | 12405 | Values: 75.0 75.0 81.0 77.0 75.0 75.0 81.0 74.0 75.0 73.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:130.00 stddev:15.92 (12.2%) stddev-sans-first:16.76 04:09:14 INFO - PROCESS | 12405 | Values: 129.0 135.0 128.0 129.0 127.0 126.0 127.0 134.0 179.0 131.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:1.95 (1.3%) stddev-sans-first:1.30 04:09:14 INFO - PROCESS | 12405 | Values: 159.0 155.0 151.0 154.0 155.0 154.0 155.0 155.0 154.0 155.0 04:09:14 INFO - PROCESS | 12405 | 04:09:14 INFO - PROCESS | 12405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.73 (2.8%) stddev-sans-first:1.83 04:09:14 INFO - PROCESS | 12405 | Values: 62.0 62.0 62.0 64.0 66.0 61.0 62.0 61.0 61.0 60.0 04:09:14 INFO - PROCESS | 12405 | -------- Summary: end -------- 04:09:14 INFO - PROCESS | 12405 | 04:09:15 INFO - TEST-INFO | 12405: exit 0 04:09:15 INFO - TEST-OK | kraken | took 59759ms 04:09:15 INFO - SUITE-END | took 1175s 04:09:15 INFO - Completed test suite (00:19:35) 04:09:15 INFO - javascript benchmark 04:09:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.4224839528883, 3253.837308134594, 3268.444364458043, 3271.869125234991, 3289.5723555937725, 5614.29821272341, 5651.8304450866435, 5653.208550802891, 5673.489385955263, 5696.174054762057, 5598.776048958047, 5654.236678048463, 5657.094864821629, 5667.064934285838, 5680.261565996425, 5073.492650734934, 5085.3389059422225, 5104.387473503185, 5142.04872098663, 5160.690358578498, 4968.403791545002, 4984.252362145671, 5186.247994040862, 5186.351706036746, 5190.92213616796, 5057.963117560909, 5075.695458272516, 5104.183330667094, 5117.309163262968, 5141.768620412072, 5135.871603209912, 5195.038917800219, 5199.870003249949, 5202.609804264657, 5221.6083793715625, 4902.264660300983, 5109.259157422191, 5136.229565565195, 5164.535191832715, 5193.350831146106, 5464.508194262496, 5479.0959491683825, 5481.424450432727, 5506.862328441781, 5539.279893613804, 5925.703714814285, 5958.731857066442, 6012.549058820562, 6027.7287522061615, 6037.154798328237, 5867.471927526543, 6088.056351265561, 6099.054646529795, 6100.572959892809, 6100.908486372708, 5522.585806064561, 5583.134614134816, 5696.886062278814, 5703.971480142573, 5705.5150312223095, 6242.968785156136, 6250.562460627803, 6250.781222657185, 6251.0623406488485, 6261.655608941552, 5802.65184088956, 5984.102384642339, 6003.249593800775, 6006.699665016732, 6011.669358185254, 5928.407159284124, 5929.0513517836935, 5989.8203053908455, 6004.639721616717, 6058.273007239071, 5982.192404025488, 5996.340402555716, 5999.160117583542, 6003.429674180946, 6034.24571928509, 5960.046392577254, 6001.0, 6010.4891084258325, 6020.247469066367, 6020.729067191987, 4515.525869783691, 4577.748223847654, 4582.518835522289, 4623.075384923029, 4646.907061858744, 4115.279826030493, 4157.771322577288, 4161.91676166475, 4170.52039015511, 4172.937405938914, 5781.8554536136935, 5784.363719990798, 5794.507466865363, 5796.536277097822, 5799.971000145057, 5881.382454842265, 5899.0, 5938.554608404387, 5979.19280897082, 6082.452579267887, 5666.914996275059, 5668.943310566924, 5672.517835983987, 5678.829635110953, 5701.743421546041, 5114.539691427789, 5123.077845987758, 5127.230915362726, 5132.153194722829, 5139.820106296262, 6017.819465416044, 6114.814446323713, 6148.415900489446, 6201.10084037812, 6220.533459990428, 5993.760249590142, 6087.908681369694, 6092.939070609237, 6131.325554189125, 6133.877322453615, 6296.653684047421, 6299.622022678654, 6324.620522768649, 6336.049592561153, 6343.143675603735, 5794.478496935296, 5801.709914504342, 5971.134185542985, 5973.880522389615, 5976.581639285208, 5937.9406205937385, 6024.1265016573225, 6025.0661147522205, 6092.8172154833655, 6103.725332359965, 5912.911306330322, 5947.434993675594, 5957.076653118774, 5964.9105263420215, 5970.940290597038, 5668.26312579362, 5906.970465147647, 5921.970390148022, 5930.406959304035, 5935.169076329231, 5769.394213607511, 5832.24180856486, 5896.469317761251, 5897.174395584536, 5969.462748352669, 5975.850603734768, 5993.370696077023, 6006.15913772081, 6011.549133814894, 6013.789517366871, 5661.377248502744, 5680.233168522197, 5717.285339332583, 5852.590318677822, 5860.033094539353], "value": 5556.50060784847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3285772075532, 621.3817251834424, 648.0667838312829, 659.3208994735418, 677.2989955396166, 34302.828485857564, 45022.32466513005, 45934.0813183737, 46018.53981460184, 46050.76974615131, 46407.535924640826, 46779.298310525366, 46876.0, 46914.0, 46917.53082469174, 8297.626606802678, 8847.77880552985, 8995.370324077317, 8997.190252877239, 8998.370114092017, 8343.791405214888, 10534.473276336152, 10759.300645458059, 10786.298890572127, 10987.670369888916, 10829.0, 10876.075533579615, 10907.072898803612, 10919.890801092006, 10926.836097458545, 10642.308249963728, 10683.0, 10703.197260205516, 10710.732231694192, 10723.946380268128, 10709.946450267698, 10758.408287544182, 10759.246852720313, 10760.139188864872, 10761.623343182951, 42637.0, 42874.571254287366, 42887.35668964968, 42893.785531072455, 42960.14079718388, 3582.4805403216646, 3638.399664055428, 3641.453781932731, 3668.064643515913, 3677.5770786359376, 32862.83568582142, 32925.0, 33144.0, 33267.500987485204, 33268.50097248519, 4459.799309031101, 4535.591796738309, 4537.500874903758, 4562.58936695699, 4579.473360563545, 358748.0, 360164.0, 361045.0, 361491.0, 364099.0, 60396.88610898597, 60797.39202608006, 60822.087668685, 60871.391286086575, 60910.69544652337, 39655.80172099179, 40497.59502404997, 40775.0, 42807.0, 42838.78580607139, 17357.218925148398, 17467.912660436872, 17478.82521174772, 17495.387661432043, 17505.12474376276, 13249.801252981213, 13705.109167904055, 14126.576202713935, 14538.709225815424, 14747.336369863382, 19566.119524621427, 19949.900250498653, 20016.799832001783, 20089.196432142842, 20319.0, 7097.432205423554, 7263.854722905512, 7338.963305183546, 7371.741989030358, 7499.0, 1041.4480325427535, 1056.3397876327294, 1076.2681376663786, 1079.0881704959297, 1138.5901075612774, 33568.83215583907, 33639.0, 33755.324893501995, 33799.32401351959, 33873.0, 1045.7529371302148, 1104.3484344236938, 1152.991132758836, 1167.2821214952744, 1167.7255844876447, 15142.621434464227, 17931.614627146373, 18579.349722759907, 18599.90700046491, 18710.438686839418, 507194.0, 508766.0, 510817.0, 512220.0, 512938.0, 60154.69922650359, 60654.39345606576, 60669.69665151646, 60727.0, 60806.69596651988, 1347.6765576261625, 1377.9931100344634, 1397.0290647999543, 1403.333416627094, 1434.8995570309978, 30396.124479177015, 31998.0, 32063.839680801448, 32144.761563034397, 32358.83820580882, 51575.48424515857, 51668.48331516787, 51957.48042519527, 52111.218331724296, 52122.73938630283, 332662.0, 333955.0, 333970.0, 333994.0, 335156.0, 27213.72786272112, 29691.85154074216, 29901.401971960873, 31540.526892097096, 31696.0, 47815.521844782495, 48703.26945095755, 48773.0, 48880.0, 49897.50102498929, 40642.1871562573, 40661.39007914943, 43432.131357373306, 43942.0, 44705.0, 42482.36276455918, 43454.13091738211, 43628.12743745171, 43663.34504982364, 44014.779926100164, 43725.0, 44377.0, 44783.77608111939, 44827.551724483645, 44848.32727509025, 35808.46287305745, 37664.43503347507, 37942.43086353762, 38043.80978095092, 38206.0, 28788.712112879442, 28841.827398986516, 29082.27294317659, 29145.562816557343, 29226.56160157557], "value": 20745.70645171887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.2202503343782, 420.1617772543774, 423.5679606801062, 428.55644408037676, 445.40093574142765, 18203.18085686144, 19429.805701942976, 20133.0, 20154.798452015475, 20439.080241389136, 16513.91743041286, 17753.28986840525, 19436.22255109794, 19893.701594476093, 19926.003699814988, 5410.0, 5820.767169313222, 5846.824595262149, 5852.209951656536, 5853.531717462614, 5584.134459158837, 5781.566382521307, 5788.6237394569425, 5846.298444186704, 5848.619839710405, 5679.971600141994, 5707.77168913243, 5717.142428635696, 5721.656700597978, 5725.656460612356, 5509.504144626962, 5707.914381284263, 5711.8000869969555, 5714.771409143608, 5718.085106382959, 5191.091558977164, 5193.506616871391, 5198.16829307309, 5205.531502164786, 5206.5314121729225, 23021.654675179885, 23068.53862922732, 23078.307650770505, 23080.076796928104, 23291.767082329297, 2455.987720061406, 2496.213692686798, 2508.761667641571, 2523.7854782343525, 2533.518631460017, 14061.296935153303, 14311.069780464237, 14410.567682969528, 14822.851771482363, 15316.0, 1969.7045443183495, 2026.432598872318, 2044.2231951858348, 2060.1862264405477, 2131.5097527568746, 77300.99999999943, 92563.53718231434, 99277.50361248148, 99382.0, 101042.0, 16688.91655541739, 17587.0, 17765.0, 17896.373626922996, 18586.163622637014, 29319.267018324714, 29371.0, 30588.847055764578, 32852.835735821165, 33131.3373732524, 9996.700098997042, 10077.0, 10094.747631309128, 10165.745856353502, 10282.228832837418, 8319.0, 8417.116202798741, 8449.788755281044, 8632.741017769476, 8688.95655521731, 8898.154675305836, 9108.544572771334, 9171.266298696088, 9240.306976976754, 9263.444193348421, 3525.823708814549, 3537.239493508908, 3565.322588708189, 3581.463828512922, 3615.2769446110883, 972.8832540095234, 1018.1345856022322, 1041.578160844859, 1077.7605753383514, 1091.7980173667897, 19502.609947800964, 19739.703904441445, 19907.502312442306, 20023.399298021082, 20272.695909561367, 1004.4977511244377, 1007.6473234368059, 1009.65671671632, 1068.529846867376, 1076.8169411200115, 10201.591936322464, 10871.782564348669, 10919.0, 10995.945020275007, 11012.0, 492009.0, 494806.0, 530719.0, 559466.0, 561472.0, 85005.0, 88824.0, 89241.55379223062, 89370.55314723385, 90592.54703726439, 997.2072202598952, 1047.7433028907967, 1058.714147180257, 1072.1958531101673, 1076.1337123615408, 16705.16474176262, 16896.23966921467, 17485.21316540733, 17503.912480437517, 17856.107194640477, 31997.16211422505, 35355.0, 41168.38247426351, 42244.577554224066, 43381.34927976146, 53257.4674253268, 58007.419925800205, 58025.70987145037, 58707.0, 60427.395726042174, 8678.566071696516, 8860.424072435271, 8881.067487913677, 8909.55452227399, 9002.909970900208, 12387.75224495487, 12525.248485090924, 12882.227066376048, 12927.224366538037, 12936.482540698267, 11049.83425248638, 11351.318920864775, 11475.254108482923, 11836.70408239801, 12157.817632735692, 11183.329000259684, 11691.298522088702, 12193.695157620776, 12208.267503949792, 12772.74454510886, 11765.294082355085, 11815.0, 12118.878811211775, 12189.69525761863, 12255.938720306342, 7749.341305988829, 8177.877331839908, 8235.794105147419, 8913.509756963429, 9307.488088155216, 9343.0, 12005.63983080509, 12168.75662486763, 12282.07884408655, 12697.55558555446], "value": 10167.309032555699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.2878889344217, 1481.11133320008, 1615.6445581971961, 1764.126757255159, 1826.0504537640436, 8180.181981801817, 8760.16778406052, 8773.429727067753, 8779.0, 8779.4732316061, 7394.37147842434, 7564.962175189116, 7940.245676660722, 8083.47457415269, 8617.13828617138, 2447.559439300925, 2477.2320580619976, 2478.281298423455, 2478.7521247875247, 2483.838550494221, 2454.6808914841044, 2517.9748202518017, 2518.5718427867214, 2521.382261345973, 2523.6971563412417, 2466.1861585676775, 2467.5558399488086, 2487.577111890974, 2488.365466805971, 2488.701355837302, 2413.1553956115395, 2414.215380001489, 2414.3360575841784, 2422.63660450932, 2449.6815413996155, 2405.579023670868, 2412.0592968742203, 2427.8421902576274, 2434.549608322466, 2436.305652888936, 8229.382796290301, 8234.176582341717, 8257.504549726975, 8280.544570048645, 8293.709720159766, 5324.653897496651, 5472.1244600864065, 5485.780568777244, 5493.0, 5493.2034854945805, 3510.78935263885, 3589.958911915541, 3614.313280476701, 3619.89140325788, 3691.9446208306895, 1185.6028230542693, 1197.1440420099584, 1201.645514573203, 1252.2549083295426, 1288.465286905933, 11514.194006419553, 11547.769044619145, 11572.942135289353, 11590.362530060844, 11623.360715160663, 4707.815747498617, 4743.051389722069, 4746.786394612251, 4819.975900120477, 4878.195097808822, 10116.898831011742, 10124.54439550222, 10131.392116472887, 10131.949340253399, 10132.290739648153, 5339.46605339463, 5352.946470535245, 5355.919661205085, 5368.865778355573, 5370.516653501126, 4397.296432570837, 4507.301368287921, 4855.32025516428, 4872.561469467765, 4912.9508704913205, 3936.4685767421606, 4074.8573799916862, 4093.570175131628, 4145.0880806222585, 4159.209750147523, 1359.789232668938, 1362.611655678127, 1366.6310096274149, 1372.6568357910523, 1378.2970684950747, 889.3107841422819, 977.1108291454884, 979.6718099436627, 988.0909563201872, 989.5942663507927, 5558.471945165203, 5568.582356323211, 5778.7688492460675, 5886.381929897385, 5919.496842768327, 970.4856426094182, 992.846108853129, 1038.1383451735041, 1070.8500809886623, 1099.6755956992706, 3800.8669696560487, 4014.979925100356, 4036.899077523027, 4042.6361627453084, 4159.729617574848, 10340.741481463023, 10366.170706343475, 10440.112590429899, 10465.633702820365, 10747.30142540748, 9922.305438619227, 10120.544575494121, 10172.847407288897, 10251.231157663056, 10383.480825958823, 7927.326177274997, 8125.0, 8154.551499667576, 8206.876896846552, 8217.096119426858, 5503.7798488060025, 5568.97215513936, 5657.236273103078, 5726.627769194989, 5833.095870139965, 9145.359824812465, 9334.113259240361, 9400.623975041195, 9478.763030924281, 9594.0, 8803.163699448542, 9073.228775554151, 9104.408213466104, 9440.19758320523, 9507.191888689262, 7185.820354491179, 7513.39892808585, 7853.253940875607, 8281.54451505173, 8419.957900210704, 8246.876296855671, 8559.529225892637, 8592.0, 8597.8710319344, 8609.0, 7488.475806693479, 7596.468247222641, 7622.733204337822, 7657.272559106876, 7823.413244006609, 7304.96347518259, 7364.226756190523, 7515.699372025277, 7544.924550754642, 7555.320021198118, 6800.52396332252, 6886.380225779503, 6890.035395044598, 6894.931050689429, 6907.620080895398, 5058.898822023612, 5082.872928176826, 5124.513171248875, 5142.460041695717, 5323.30796996388, 4979.950200497949, 5010.198368261206, 5092.898142037213, 5161.380634323905, 5282.683039017671], "value": 4649.005910986368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8555613864107, 344.28904312594506, 346.9496922946173, 348.6948919695267, 350.7920070951152, 5398.811041613544, 5434.972825135868, 5442.455754424555, 5450.781968721251, 5482.369527504328, 5154.381474223089, 5204.193350030751, 5278.6568873023225, 5284.365876094865, 5432.429594892538, 4207.600277973587, 4224.61978421942, 4239.198340705196, 4244.363345498185, 4260.744355338674, 4210.473690788652, 4222.627646015042, 4234.703570750049, 4247.15056988602, 4286.549912259199, 3958.2083583283315, 3999.560048394674, 4163.958360416387, 4208.410822484854, 4237.491501019882, 4163.3130533461945, 4164.895877603084, 4172.165566886604, 4183.3097538906195, 4190.497140343148, 3744.4383342498572, 3748.5314335708035, 3749.775013499199, 3759.4360845873066, 3766.472693822867, 5091.134507133796, 5208.088584497736, 5220.765065572058, 5261.631685781997, 5261.842144735626, 4838.661293709407, 4855.805767769285, 4863.781129849165, 4877.146499362633, 4882.707037577757, 5603.8879222415735, 5604.271444712162, 5612.943870561283, 5625.212470254168, 5626.115251390789, 4071.89820254496, 4101.6540213955905, 4112.157007813421, 4145.564715704838, 4160.687948403852, 5797.913031304533, 5804.100364443518, 5811.041178205591, 5820.417958204146, 5831.620944638627, 4245.681573881971, 4248.787560622019, 4250.639795265547, 4251.128518653669, 4289.420928174719, 4234.978825105854, 4248.214080395137, 4291.935620965688, 4345.587169218919, 4347.5217726050105, 4826.734529600905, 4830.3237546743485, 4831.855044348676, 4836.733979631154, 4860.684055536379, 5630.577706672016, 5633.732410207753, 5638.9436105638415, 5641.435856414326, 5647.604667673223, 1392.3386391464176, 1436.727021865842, 1441.889744896424, 1441.9495317663832, 1452.678062962699, 954.7613096725819, 965.7875267441152, 1006.0, 1030.9123724483352, 1031.2729525684374, 5231.293775340357, 5256.842294731164, 5284.497972692588, 5316.76074576645, 5329.893402132013, 5541.833744987657, 5554.500474786362, 5601.915971260434, 5607.383187849333, 5646.830595082154, 5153.407358153785, 5247.763850626731, 5285.709285989231, 5312.973435132877, 5330.307060082165, 2892.944075412501, 2894.653985896526, 2917.139443864065, 2922.473954688134, 2925.297928497145, 5539.335279766454, 5708.372079071299, 5714.685622306893, 5721.6554109784165, 5757.416710404672, 5571.804986825442, 5574.303212098488, 5575.832725018256, 5596.608237423341, 5605.607607467438, 5667.631603945731, 5691.231683722644, 5703.743331550173, 5716.997152989427, 5720.570957178228, 5290.365156181283, 5517.944310931382, 5523.226748255167, 5566.638168519034, 5567.494627417759, 5443.428440013741, 5466.480684334982, 5479.643823151482, 5498.257735205696, 5520.779168833202, 5424.430434804446, 5693.658380497183, 5712.5429965601825, 5722.6852523109965, 5763.827085187451, 4079.204555111725, 4086.8773936781945, 4097.893568736365, 4103.076807718239, 4106.733062350938, 5450.836474905759, 5488.945110548843, 5522.806701765419, 5537.141743029837, 5550.361708403424, 5417.539509141609, 5434.592405569677, 5435.945640543702, 5447.0, 5448.645838020516, 5618.971905140448, 5620.971895140498, 5631.802886898939, 5663.688497132697, 5673.319201695823, 5407.891842163213, 5561.693002144412, 5627.577931655061, 5653.830385088454, 5666.9716651416475, 5557.44425557441, 5666.17840413146, 5723.02708539541, 5734.455226753452, 5742.59801813869, 5562.4993750561025, 5573.470520300565, 5587.329520457409, 5588.497035266845, 5597.888042239214], "value": 4266.043684861023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.533738407419, 752.1650967426156, 795.614127148333, 797.7806103321584, 832.4921797703396, 15034.548963531099, 15970.680586388266, 15994.76007859883, 16011.27949242284, 16019.759703604455, 14649.560513184595, 14821.0, 14832.55502334929, 14835.406583736638, 14836.777448338256, 709.5707097206193, 732.3811379384438, 823.3660081737058, 850.0819115355432, 850.3664769746532, 848.6053984897021, 848.719922425598, 855.7347222361057, 858.1847245117133, 866.7009881590841, 893.0399820193286, 899.6356475627381, 901.364538000708, 902.1024081039375, 903.5933829776594, 749.3143773447289, 886.4016788667624, 886.778305423644, 887.9378443508957, 888.6134531478795, 560.0758748065683, 632.2665707778955, 648.1315037849257, 654.2574178307608, 657.6810247030187, 14672.239331280314, 14762.335694893649, 14772.335244914004, 14795.630109247248, 14863.628409289746, 13752.724945501133, 14034.508792192326, 14194.92902535491, 14223.786643200257, 14263.0, 12044.759104817855, 12216.816747748791, 12303.569375071918, 12317.630471085882, 12354.938225308906, 3912.1979994101425, 3949.624785645388, 3950.7036972227197, 3979.064919743858, 4055.330870406409, 66881.331186688, 66975.66512167409, 67310.3268967309, 69156.6542167291, 69745.99999999949, 10998.0, 11147.275427097213, 11427.48576314068, 11530.481128349244, 11695.181337306307, 20186.0, 20394.0, 20407.795922040885, 20456.386308410772, 20669.17323307081, 8260.586970651444, 8360.372972027, 8456.323494120456, 8584.699535516227, 8853.911460885438, 4421.845235416745, 4566.406367172246, 4842.95157048425, 4849.199882019428, 4943.826966056243, 3349.0120414477788, 3402.9489557656657, 3430.9313813723584, 3435.3301106284534, 3444.328355970612, 577.3245302995506, 579.2643342954508, 583.4981915552621, 591.8283697727696, 595.8867815115115, 617.4566381584177, 633.2907143998751, 675.2032601530143, 687.6046273392819, 709.8331892005375, 8965.596548155349, 9533.618655253851, 9538.809223815484, 9571.61713531465, 9703.6118555257, 620.314552419579, 687.285223367692, 690.7133539581017, 690.944724422045, 706.3254591864757, 4552.817887284537, 4710.599599034121, 4737.478877323491, 4829.27560865873, 4856.781444834991, 89529.0, 89829.30512084517, 93857.0, 94415.52792236132, 97145.51427242819, 81610.59194703988, 82516.58741706373, 82612.58693706493, 82814.0, 85483.5725821367, 73679.63160184165, 75674.0, 76781.6160919203, 77127.61436192783, 77755.61122194353, 9709.90635241936, 10250.538725757508, 10412.427316497666, 10604.204684648528, 10725.839112413163, 35752.64247357493, 45697.60479041916, 45808.0, 48572.0, 50708.74645626748, 55813.441865580826, 56765.43234567602, 59401.405985939586, 63148.0, 65211.347886520525, 12739.490420383452, 12814.295213763333, 12833.358332083546, 13056.412461439448, 13237.867621324049, 14043.578692639237, 14503.492377766728, 14618.780718289021, 15048.699026019638, 15340.693186135992, 13720.86279137196, 13879.375428105557, 14105.647358816112, 14333.928330358282, 14550.636234094232, 13573.253471059186, 13723.245221512514, 13955.651108721957, 14643.41426342977, 14662.0, 13757.899368050732, 13926.234057126956, 13961.371738272006, 14500.637484062561, 14536.781948270997, 11338.376389298668, 11744.823827642764, 11838.70215100218, 12049.819252711392, 12417.94447471975, 11647.6505704829, 12021.819672704742, 12022.087299802823, 12039.699007524881, 12207.206531575419], "value": 7404.2684206862805, "unit": "score"}], "name": "dromaeo_css", "value": 7458.329692281926, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 110.0, 110.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 123.0, 154.0, 128.0, 123.0, 123.0, 124.0, 147.0, 122.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 161.0, 163.0, 160.0, 162.0, 158.0, 158.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 76.0, 101.0, 75.0, 75.0, 76.0, 76.0, 96.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 84.0, 82.0, 81.0, 103.0, 82.0, 82.0, 110.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 148.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 50.0, 50.0, 49.0, 51.0, 51.0, 49.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 59.0, 63.0, 59.0, 63.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 81.0, 77.0, 75.0, 75.0, 81.0, 74.0, 75.0, 73.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 135.0, 128.0, 129.0, 127.0, 126.0, 127.0, 134.0, 179.0, 131.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 151.0, 154.0, 155.0, 154.0, 155.0, 155.0, 154.0, 155.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 64.0, 66.0, 61.0, 62.0, 61.0, 61.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1458.6, "alertThreshold": 2.0}]} 04:09:15 INFO - Return code: 0 04:09:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:09:15 ERROR - # TBPL SUCCESS # 04:09:15 INFO - Running post-action listener: _resource_record_post_action 04:09:15 INFO - [mozharness: 2016-11-18 12:09:15.728014Z] Finished run-tests step (success) 04:09:15 INFO - Running post-run listener: _resource_record_post_run 04:09:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 462848; Write bytes: 353128448; Read time: 104; Write time: 225852 04:09:15 INFO - TinderboxPrint: CPU usage
13.0% 04:09:15 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 104 04:09:15 INFO - TinderboxPrint: I/O write bytes / time
353,128,448 / 225,852 04:09:15 INFO - TinderboxPrint: CPU idle
8,270.9 (87.0%) 04:09:15 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 04:09:15 INFO - TinderboxPrint: Swap in / out
0 / 0 04:09:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107487232; Read time: 0; Write time: 68640 04:09:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 458752; Write bytes: 243277824; Read time: 88; Write time: 157048 04:09:16 INFO - Running post-run listener: _upload_blobber_files 04:09:16 INFO - Blob upload gear active. 04:09:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:16 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 04:09:16 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'] 04:09:16 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 04:09:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:09:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:09:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:17 INFO - (blobuploader) - INFO - Done attempting. 04:09:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:09:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:09:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:18 INFO - (blobuploader) - INFO - Done attempting. 04:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:09:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:21 INFO - (blobuploader) - INFO - Done attempting. 04:09:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:21 INFO - Return code: 0 04:09:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a71e9eb2fdc683a21fcee07f9c7c5b6b048c9c7ea09ea32d2e3afcc1933e6710a7b95f9ddf8bf3bc4717f589a75b5713e9116f8af3fafca53208d97457b85bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fea39a205e886017ced546abea8dabe6ed1e43f885c6ea4e6d74d3401250297f26e573a83b73b70c34a08a9ff74a4dad5e381b56ad268d7073c7d503aae1df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39ccda1e2b72cb85275590b1329fdb3b3d2da450763d2cca6987ac4ac1ab5df7464de71bb9741eeec0e51aeec266998147509976a6c0b8b3ec81fabd681b6994"} 04:09:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:21 INFO - Contents: 04:09:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a71e9eb2fdc683a21fcee07f9c7c5b6b048c9c7ea09ea32d2e3afcc1933e6710a7b95f9ddf8bf3bc4717f589a75b5713e9116f8af3fafca53208d97457b85bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fea39a205e886017ced546abea8dabe6ed1e43f885c6ea4e6d74d3401250297f26e573a83b73b70c34a08a9ff74a4dad5e381b56ad268d7073c7d503aae1df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39ccda1e2b72cb85275590b1329fdb3b3d2da450763d2cca6987ac4ac1ab5df7464de71bb9741eeec0e51aeec266998147509976a6c0b8b3ec81fabd681b6994"} 04:09:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:21 INFO - Copying logs to upload dir... 04:09:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.000346 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-18 04:09:21.497725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 04:09:21.504022) ========= 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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 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/a71e9eb2fdc683a21fcee07f9c7c5b6b048c9c7ea09ea32d2e3afcc1933e6710a7b95f9ddf8bf3bc4717f589a75b5713e9116f8af3fafca53208d97457b85bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fea39a205e886017ced546abea8dabe6ed1e43f885c6ea4e6d74d3401250297f26e573a83b73b70c34a08a9ff74a4dad5e381b56ad268d7073c7d503aae1df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39ccda1e2b72cb85275590b1329fdb3b3d2da450763d2cca6987ac4ac1ab5df7464de71bb9741eeec0e51aeec266998147509976a6c0b8b3ec81fabd681b6994"} build_url:https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011937 build_url: 'https://queue.taskcluster.net/v1/task/ChiBD2r4R7uOCOtO9AP7FQ/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/a71e9eb2fdc683a21fcee07f9c7c5b6b048c9c7ea09ea32d2e3afcc1933e6710a7b95f9ddf8bf3bc4717f589a75b5713e9116f8af3fafca53208d97457b85bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fea39a205e886017ced546abea8dabe6ed1e43f885c6ea4e6d74d3401250297f26e573a83b73b70c34a08a9ff74a4dad5e381b56ad268d7073c7d503aae1df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39ccda1e2b72cb85275590b1329fdb3b3d2da450763d2cca6987ac4ac1ab5df7464de71bb9741eeec0e51aeec266998147509976a6c0b8b3ec81fabd681b6994"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 04:09:21.529662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:09:21.529989) ========= 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=41bf3e9aed84707956354da8000001c5-1479469725.864173-649691418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:09:21.615857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 04:09:21.616188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 04:09:21.616478) ========= ========= Total master_lag: 0.18 =========