builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1481711915.97 results: success (0) buildid: 20161214005401 builduid: 531a823615bb45acabe4d089c5c6d9ec revision: 450277eb1728b1ac8843f684d0a1474462d91c6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:35.965518) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:35.965921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:35.966206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:35.993096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-14 02:38:35.993362) ========= 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-1481711915.68342-1868818991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 02:38:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-12-14 02:38:37 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116716 ========= master_lag: 2.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-14 02:38:38.204164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:38.204511) ========= 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-1481711915.68342-1868818991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015735 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:38.236647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:38.236990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 450277eb1728b1ac8843f684d0a1474462d91c6d --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 450277eb1728b1ac8843f684d0a1474462d91c6d --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-1481711915.68342-1868818991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 02:38:39,282 truncating revision to first 12 chars 2016-12-14 02:38:39,282 Setting DEBUG logging. 2016-12-14 02:38:39,282 attempt 1/10 2016-12-14 02:38:39,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/450277eb1728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 02:38:39,742 unpacking tar archive at: mozilla-aurora-450277eb1728/testing/mozharness/ program finished with exit code 0 elapsedTime=0.761918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:39.016330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:39.016640) ========= script_repo_revision: 450277eb1728b1ac8843f684d0a1474462d91c6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:39.021065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:39.021366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 02:38:39.031359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-14 02:38:39.031683) ========= /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-1481711915.68342-1868818991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:40 INFO - MultiFileLogger online at 20161214 02:38:40 in /builds/slave/test 02:38:40 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 02:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:40 INFO - {'append_to_log': False, 02:38:40 INFO - 'base_work_dir': '/builds/slave/test', 02:38:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:40 INFO - 'branch': 'Mozilla-Aurora', 02:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:40 INFO - 'config_files': ('talos/linux_config.py',), 02:38:40 INFO - 'default_actions': ('clobber', 02:38:40 INFO - 'read-buildbot-config', 02:38:40 INFO - 'download-and-extract', 02:38:40 INFO - 'populate-webroot', 02:38:40 INFO - 'create-virtualenv', 02:38:40 INFO - 'install', 02:38:40 INFO - 'run-tests'), 02:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:40 INFO - 'download_minidump_stackwalk': True, 02:38:40 INFO - 'download_symbols': 'ondemand', 02:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:40 INFO - 'installer_path': 'installer.exe', 02:38:40 INFO - 'log_level': 'info', 02:38:40 INFO - 'log_name': 'talos', 02:38:40 INFO - 'log_to_console': True, 02:38:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:40 INFO - 'opt_config_files': (), 02:38:40 INFO - 'pip_index': False, 02:38:40 INFO - 'sps_profile': False, 02:38:40 INFO - 'sps_profile_interval': 0, 02:38:40 INFO - 'suite': 'dromaeojs', 02:38:40 INFO - 'system_bits': '32', 02:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:40 INFO - 'title': 'talos-linux64-ix-026', 02:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:40 INFO - 'use_talos_json': True, 02:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:40 INFO - 'work_dir': 'build'} 02:38:40 INFO - [mozharness: 2016-12-14 10:38:40.174670Z] Running clobber step. 02:38:40 INFO - Running pre-action listener: _resource_record_pre_action 02:38:40 INFO - Running main action method: clobber 02:38:40 INFO - rmtree: /builds/slave/test/build 02:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:40 INFO - Running post-action listener: _resource_record_post_action 02:38:40 INFO - [mozharness: 2016-12-14 10:38:40.635320Z] Finished clobber step (success) 02:38:40 INFO - [mozharness: 2016-12-14 10:38:40.635424Z] Running read-buildbot-config step. 02:38:40 INFO - Running pre-action listener: _resource_record_pre_action 02:38:40 INFO - Running main action method: read_buildbot_config 02:38:40 INFO - Using buildbot properties: 02:38:40 INFO - { 02:38:40 INFO - "project": "", 02:38:40 INFO - "product": "firefox", 02:38:40 INFO - "script_repo_revision": "production", 02:38:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:38:40 INFO - "repository": "", 02:38:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:38:40 INFO - "buildid": "20161214005401", 02:38:40 INFO - "pgo_build": "True", 02:38:40 INFO - "basedir": "/builds/slave/test", 02:38:40 INFO - "buildnumber": 668, 02:38:40 INFO - "slavename": "talos-linux64-ix-026", 02:38:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:38:40 INFO - "platform": "ubuntu64_hw", 02:38:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:38:40 INFO - "branch": "mozilla-aurora", 02:38:40 INFO - "repo_path": "releases/mozilla-aurora", 02:38:40 INFO - "revision": "450277eb1728b1ac8843f684d0a1474462d91c6d", 02:38:40 INFO - "stage_platform": "linux64-pgo", 02:38:40 INFO - "builduid": "531a823615bb45acabe4d089c5c6d9ec", 02:38:40 INFO - "slavebuilddir": "test" 02:38:40 INFO - } 02:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:38:40 INFO - Running post-action listener: _resource_record_post_action 02:38:40 INFO - [mozharness: 2016-12-14 10:38:40.637867Z] Finished read-buildbot-config step (success) 02:38:40 INFO - [mozharness: 2016-12-14 10:38:40.637956Z] Running download-and-extract step. 02:38:40 INFO - Running pre-action listener: _resource_record_pre_action 02:38:40 INFO - Running main action method: download_and_extract 02:38:40 INFO - mkdir: /builds/slave/test/build/tests 02:38:40 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')]} 02:38:40 INFO - trying https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:38:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:38:41 INFO - Downloaded 1361 bytes. 02:38:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:38:41 INFO - Using the following test package requirements: 02:38:41 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:41 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:41 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:38:41 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'jsshell-linux-x86_64.zip'], 02:38:41 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:41 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:41 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:38:41 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:38:41 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:41 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:41 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:38:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:41 INFO - Fetch https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:38:41 INFO - Http code: 200 02:38:41 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 02:38:41 INFO - x-amz-cf-id: MSunnDOo9PbQfVcbzWhN540N3Hf3ctR9tir_VCsuLUE4ZMmoni4idg== 02:38:41 INFO - x-amz-version-id: G3b3W8W6L8ZFpO91JwgQrQWpitHduF8. 02:38:41 INFO - Expected file size: 21953855 02:38:41 INFO - Obtained file size: 21953855 02:38:46 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 02:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:38:46 INFO - Http code: 200 02:38:46 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:38:46 INFO - x-amz-cf-id: OMS6z-H1wACNSXHppW6npHA8b77e-rdEf79oxawODmDJvG6ysSBtFQ== 02:38:46 INFO - x-amz-version-id: G3b3W8W6L8ZFpO91JwgQrQWpitHduF8. 02:38:46 INFO - Expected file size: 21953855 02:38:46 INFO - Obtained file size: 21953855 02:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:38:51 INFO - Http code: 200 02:38:51 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:38:51 INFO - x-amz-cf-id: oeX6TyDHOM6Kpzh-C2WyInN8tC3nvsqOzA5uu0AxArvrcTBh7DQLnw== 02:38:51 INFO - x-amz-version-id: h_KjT_mYjj5ilps4U1r.5VGua2Snw5db 02:38:52 INFO - Expected file size: 14409038 02:38:52 INFO - Obtained file size: 14409038 02:38:52 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')]} 02:38:52 INFO - trying https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:38:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:38:53 INFO - Downloaded 64013868 bytes. 02:38:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:38:53 INFO - mkdir: /builds/slave/test/properties 02:38:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:53 INFO - Contents: 02:38:53 INFO - build_url:https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:38:54 INFO - Running post-action listener: _resource_record_post_action 02:38:54 INFO - Running post-action listener: set_extra_try_arguments 02:38:54 INFO - [mozharness: 2016-12-14 10:38:54.143807Z] Finished download-and-extract step (success) 02:38:54 INFO - [mozharness: 2016-12-14 10:38:54.144033Z] Running populate-webroot step. 02:38:54 INFO - Running pre-action listener: _resource_record_pre_action 02:38:54 INFO - Running main action method: populate_webroot 02:38:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:54 INFO - '--tppagecycles', 02:38:54 INFO - '7'], 02:38:54 INFO - 'tests': ['tsvgm']}}, 02:38:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['damp', 'tps']}, 02:38:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'tests': ['damp', 'tps']}, 02:38:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['dromaeo_dom']}, 02:38:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['basic_compositor_video']}, 02:38:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:38:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['a11yr', 02:38:54 INFO - 'ts_paint', 02:38:54 INFO - 'tpaint', 02:38:54 INFO - 'sessionrestore', 02:38:54 INFO - 'sessionrestore_no_auto_restore', 02:38:54 INFO - 'tabpaint']}, 02:38:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['tsvgx', 02:38:54 INFO - 'tsvgr_opacity', 02:38:54 INFO - 'tart', 02:38:54 INFO - 'tscrollx', 02:38:54 INFO - 'cart']}, 02:38:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:54 INFO - 'tsvgr_opacity', 02:38:54 INFO - 'tart', 02:38:54 INFO - 'tscrollx', 02:38:54 INFO - 'cart']}, 02:38:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'talos_options': ['--disable-e10s'], 02:38:54 INFO - 'tests': ['tp5o']}, 02:38:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'tests': ['tp5o']}, 02:38:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'talos_options': ['--disable-e10s', 02:38:54 INFO - '--xperf_path', 02:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:54 INFO - 'tests': ['tp5n']}, 02:38:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:54 INFO - 'talos_options': ['--xperf_path', 02:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:54 INFO - 'tests': ['tp5n']}}, 02:38:54 INFO - 'talos.zip': {'path': '', 02:38:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:54 INFO - Running post-action listener: _resource_record_post_action 02:38:54 INFO - [mozharness: 2016-12-14 10:38:54.161996Z] Finished populate-webroot step (success) 02:38:54 INFO - [mozharness: 2016-12-14 10:38:54.162085Z] Running create-virtualenv step. 02:38:54 INFO - Running pre-action listener: _resource_record_pre_action 02:38:54 INFO - Running main action method: create_virtualenv 02:38:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:54 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 02:38:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:54 INFO - Using real prefix '/usr' 02:38:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:56 INFO - Installing pip.................done. 02:38:56 INFO - Return code: 0 02:38:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:38:56 INFO - Reading from file tmpfile_stdout 02:38:56 INFO - Output received: 02:38:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:38:56 INFO - Using env: {'DISPLAY': ':0', 02:38:56 INFO - 'HOME': '/home/cltbld', 02:38:56 INFO - 'LANG': 'en_US.UTF-8', 02:38:56 INFO - 'LANGUAGE': 'en_US:en', 02:38:56 INFO - 'LOGNAME': 'cltbld', 02:38:56 INFO - 'MAIL': '/var/mail/cltbld', 02:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:56 INFO - 'MOZ_NO_REMOTE': '1', 02:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:56 INFO - 'NO_EM_RESTART': '1', 02:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:56 INFO - 'PWD': '/builds/slave/test', 02:38:56 INFO - 'SHELL': '/bin/bash', 02:38:56 INFO - 'SHLVL': '1', 02:38:56 INFO - 'TERM': 'linux', 02:38:56 INFO - 'TMOUT': '86400', 02:38:56 INFO - 'USER': 'cltbld', 02:38:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:56 INFO - '_': '/tools/buildbot/bin/python'} 02:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:57 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 02:38:57 INFO - Cleaning up... 02:38:57 INFO - Return code: 0 02:38:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:38:57 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 02:38:57 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 02:38:57 INFO - Using env: {'DISPLAY': ':0', 02:38:57 INFO - 'HOME': '/home/cltbld', 02:38:57 INFO - 'LANG': 'en_US.UTF-8', 02:38:57 INFO - 'LANGUAGE': 'en_US:en', 02:38:57 INFO - 'LOGNAME': 'cltbld', 02:38:57 INFO - 'MAIL': '/var/mail/cltbld', 02:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:57 INFO - 'MOZ_NO_REMOTE': '1', 02:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:57 INFO - 'NO_EM_RESTART': '1', 02:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:57 INFO - 'PWD': '/builds/slave/test', 02:38:57 INFO - 'SHELL': '/bin/bash', 02:38:57 INFO - 'SHLVL': '1', 02:38:57 INFO - 'TERM': 'linux', 02:38:57 INFO - 'TMOUT': '86400', 02:38:57 INFO - 'USER': 'cltbld', 02:38:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:57 INFO - '_': '/tools/buildbot/bin/python'} 02:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:57 INFO - Downloading/unpacking psutil>=3.1.1 02:38:57 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 02:38:57 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 02:38:57 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 02:38:57 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 02:38:57 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 02:38:57 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 02:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:59 INFO - Installing collected packages: psutil 02:38:59 INFO - Running setup.py install for psutil 02:38:59 INFO - building 'psutil._psutil_linux' extension 02:38:59 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 02:38:59 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 02:38:59 INFO - building 'psutil._psutil_posix' extension 02:38:59 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 02:38:59 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 02:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:59 INFO - Successfully installed psutil 02:38:59 INFO - Cleaning up... 02:39:00 INFO - Return code: 0 02:39:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:00 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')]} 02:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:00 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')]} 02:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:00 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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:00 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 02:39:00 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 02:39:00 INFO - Using env: {'DISPLAY': ':0', 02:39:00 INFO - 'HOME': '/home/cltbld', 02:39:00 INFO - 'LANG': 'en_US.UTF-8', 02:39:00 INFO - 'LANGUAGE': 'en_US:en', 02:39:00 INFO - 'LOGNAME': 'cltbld', 02:39:00 INFO - 'MAIL': '/var/mail/cltbld', 02:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:00 INFO - 'MOZ_NO_REMOTE': '1', 02:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:00 INFO - 'NO_EM_RESTART': '1', 02:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:00 INFO - 'PWD': '/builds/slave/test', 02:39:00 INFO - 'SHELL': '/bin/bash', 02:39:00 INFO - 'SHLVL': '1', 02:39:00 INFO - 'TERM': 'linux', 02:39:00 INFO - 'TMOUT': '86400', 02:39:00 INFO - 'USER': 'cltbld', 02:39:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:00 INFO - '_': '/tools/buildbot/bin/python'} 02:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:02 INFO - Installing collected packages: mozsystemmonitor 02:39:02 INFO - Running setup.py install for mozsystemmonitor 02:39:02 INFO - Successfully installed mozsystemmonitor 02:39:02 INFO - Cleaning up... 02:39:02 INFO - Return code: 0 02:39:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:39:02 INFO - Using env: {'DISPLAY': ':0', 02:39:02 INFO - 'HOME': '/home/cltbld', 02:39:02 INFO - 'LANG': 'en_US.UTF-8', 02:39:02 INFO - 'LANGUAGE': 'en_US:en', 02:39:02 INFO - 'LOGNAME': 'cltbld', 02:39:02 INFO - 'MAIL': '/var/mail/cltbld', 02:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:02 INFO - 'MOZ_NO_REMOTE': '1', 02:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:02 INFO - 'NO_EM_RESTART': '1', 02:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:02 INFO - 'PWD': '/builds/slave/test', 02:39:02 INFO - 'SHELL': '/bin/bash', 02:39:02 INFO - 'SHLVL': '1', 02:39:02 INFO - 'TERM': 'linux', 02:39:02 INFO - 'TMOUT': '86400', 02:39:02 INFO - 'USER': 'cltbld', 02:39:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:02 INFO - '_': '/tools/buildbot/bin/python'} 02:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:02 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:02 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 02:39:02 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 02:39:02 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 02:39:02 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 02:39:02 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 02:39:02 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 02:39:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:04 INFO - warning: no files found matching '*.txt' 02:39:04 INFO - no previously-included directories found matching 'build' 02:39:04 INFO - no previously-included directories found matching 'dist' 02:39:04 INFO - no previously-included directories found matching '.git*' 02:39:04 INFO - Installing collected packages: jsonschema, functools32 02:39:04 INFO - Running setup.py install for functools32 02:39:05 INFO - warning: no files found matching '*.txt' 02:39:05 INFO - no previously-included directories found matching 'build' 02:39:05 INFO - no previously-included directories found matching 'dist' 02:39:05 INFO - no previously-included directories found matching '.git*' 02:39:05 INFO - Successfully installed jsonschema functools32 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:08 INFO - Downloading docopt-0.6.1.tar.gz 02:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:08 INFO - Running setup.py install for blobuploader 02:39:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:08 INFO - Running setup.py install for requests 02:39:08 INFO - Running setup.py install for docopt 02:39:08 INFO - Successfully installed blobuploader requests docopt 02:39:08 INFO - Cleaning up... 02:39:08 INFO - Return code: 0 02:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:08 INFO - Using env: {'DISPLAY': ':0', 02:39:08 INFO - 'HOME': '/home/cltbld', 02:39:08 INFO - 'LANG': 'en_US.UTF-8', 02:39:08 INFO - 'LANGUAGE': 'en_US:en', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MAIL': '/var/mail/cltbld', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SHLVL': '1', 02:39:08 INFO - 'TERM': 'linux', 02:39:08 INFO - 'TMOUT': '86400', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - '_': '/tools/buildbot/bin/python'} 02:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:09 INFO - Running setup.py (path:/tmp/pip-oLeXSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:09 INFO - Running setup.py (path:/tmp/pip-pasWo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:09 INFO - Running setup.py (path:/tmp/pip-jtqOIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:09 INFO - Running setup.py (path:/tmp/pip-mDG6xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:09 INFO - Running setup.py (path:/tmp/pip-zP9J2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:09 INFO - Running setup.py (path:/tmp/pip-_yS4SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:09 INFO - Running setup.py (path:/tmp/pip-KJuBUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:09 INFO - Running setup.py (path:/tmp/pip-tqRaYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:09 INFO - Running setup.py (path:/tmp/pip-MW2Abg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:09 INFO - Running setup.py (path:/tmp/pip-ET_x2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:09 INFO - Running setup.py (path:/tmp/pip-yvatPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:09 INFO - Running setup.py (path:/tmp/pip-w0isqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:10 INFO - Running setup.py (path:/tmp/pip-bOI7WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:10 INFO - Running setup.py (path:/tmp/pip-E945e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:10 INFO - Running setup.py (path:/tmp/pip-dDJnoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:10 INFO - Running setup.py (path:/tmp/pip-ckOtbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:10 INFO - Running setup.py (path:/tmp/pip-NdKVMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:10 INFO - Running setup.py install for manifestparser 02:39:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Running setup.py install for mozcrash 02:39:10 INFO - Running setup.py install for mozdebug 02:39:10 INFO - Running setup.py install for mozdevice 02:39:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Running setup.py install for mozfile 02:39:10 INFO - Running setup.py install for mozhttpd 02:39:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozinfo 02:39:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozInstall 02:39:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozleak 02:39:11 INFO - Running setup.py install for mozlog 02:39:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for moznetwork 02:39:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozprocess 02:39:11 INFO - Running setup.py install for mozprofile 02:39:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozrunner 02:39:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:11 INFO - Running setup.py install for mozscreenshot 02:39:12 INFO - Running setup.py install for moztest 02:39:12 INFO - Running setup.py install for mozversion 02:39:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:12 INFO - Cleaning up... 02:39:12 INFO - Return code: 0 02:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:12 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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:12 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 02:39:12 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 02:39:12 INFO - Using env: {'DISPLAY': ':0', 02:39:12 INFO - 'HOME': '/home/cltbld', 02:39:12 INFO - 'LANG': 'en_US.UTF-8', 02:39:12 INFO - 'LANGUAGE': 'en_US:en', 02:39:12 INFO - 'LOGNAME': 'cltbld', 02:39:12 INFO - 'MAIL': '/var/mail/cltbld', 02:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:12 INFO - 'MOZ_NO_REMOTE': '1', 02:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:12 INFO - 'NO_EM_RESTART': '1', 02:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:12 INFO - 'PWD': '/builds/slave/test', 02:39:12 INFO - 'SHELL': '/bin/bash', 02:39:12 INFO - 'SHLVL': '1', 02:39:12 INFO - 'TERM': 'linux', 02:39:12 INFO - 'TMOUT': '86400', 02:39:12 INFO - 'USER': 'cltbld', 02:39:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:12 INFO - '_': '/tools/buildbot/bin/python'} 02:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:12 INFO - Running setup.py (path:/tmp/pip-gmoe_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:12 INFO - Running setup.py (path:/tmp/pip-UiMlN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:12 INFO - Running setup.py (path:/tmp/pip-vI_3Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:12 INFO - Running setup.py (path:/tmp/pip-B5A4mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:12 INFO - Running setup.py (path:/tmp/pip-YyGjdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:12 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)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:12 INFO - Running setup.py (path:/tmp/pip-XpyLeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:12 INFO - Running setup.py (path:/tmp/pip-4gIeic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:12 INFO - Running setup.py (path:/tmp/pip-FxeWxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:13 INFO - Running setup.py (path:/tmp/pip-RUJn_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:13 INFO - Running setup.py (path:/tmp/pip-RRV9u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:13 INFO - Running setup.py (path:/tmp/pip-Zs1API-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:13 INFO - Running setup.py (path:/tmp/pip-_79W30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:13 INFO - Running setup.py (path:/tmp/pip-cfIeVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:13 INFO - Running setup.py (path:/tmp/pip-cpLL7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:13 INFO - Running setup.py (path:/tmp/pip-uojjXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:13 INFO - Running setup.py (path:/tmp/pip-uBotJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:13 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)) 02:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:13 INFO - Running setup.py (path:/tmp/pip-DtIZ6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 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)) 02:39:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:15 INFO - Downloading blessings-1.6.tar.gz 02:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:15 INFO - Installing collected packages: blessings 02:39:15 INFO - Running setup.py install for blessings 02:39:15 INFO - Successfully installed blessings 02:39:15 INFO - Cleaning up... 02:39:15 INFO - Return code: 0 02:39:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:16 INFO - Reading from file tmpfile_stdout 02:39:16 INFO - Current package versions: 02:39:16 INFO - argparse == 1.2.1 02:39:16 INFO - blessings == 1.6 02:39:16 INFO - blobuploader == 1.2.4 02:39:16 INFO - docopt == 0.6.1 02:39:16 INFO - functools32 == 3.2.3-2 02:39:16 INFO - jsonschema == 2.5.1 02:39:16 INFO - manifestparser == 1.1 02:39:16 INFO - mozInstall == 1.12 02:39:16 INFO - mozcrash == 1.0 02:39:16 INFO - mozdebug == 0.1 02:39:16 INFO - mozdevice == 0.48 02:39:16 INFO - mozfile == 1.2 02:39:16 INFO - mozhttpd == 0.7 02:39:16 INFO - mozinfo == 0.9 02:39:16 INFO - mozleak == 0.1 02:39:16 INFO - mozlog == 3.4 02:39:16 INFO - moznetwork == 0.27 02:39:16 INFO - mozprocess == 0.23 02:39:16 INFO - mozprofile == 0.28 02:39:16 INFO - mozrunner == 6.13 02:39:16 INFO - mozscreenshot == 0.1 02:39:16 INFO - mozsystemmonitor == 0.3 02:39:16 INFO - moztest == 0.7 02:39:16 INFO - mozversion == 1.4 02:39:16 INFO - psutil == 3.1.1 02:39:16 INFO - requests == 1.2.3 02:39:16 INFO - wsgiref == 0.1.2 02:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:16 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 02:39:16 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 02:39:16 INFO - Using env: {'DISPLAY': ':0', 02:39:16 INFO - 'HOME': '/home/cltbld', 02:39:16 INFO - 'LANG': 'en_US.UTF-8', 02:39:16 INFO - 'LANGUAGE': 'en_US:en', 02:39:16 INFO - 'LOGNAME': 'cltbld', 02:39:16 INFO - 'MAIL': '/var/mail/cltbld', 02:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:16 INFO - 'MOZ_NO_REMOTE': '1', 02:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:16 INFO - 'NO_EM_RESTART': '1', 02:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:16 INFO - 'PWD': '/builds/slave/test', 02:39:16 INFO - 'SHELL': '/bin/bash', 02:39:16 INFO - 'SHLVL': '1', 02:39:16 INFO - 'TERM': 'linux', 02:39:16 INFO - 'TMOUT': '86400', 02:39:16 INFO - 'USER': 'cltbld', 02:39:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:16 INFO - '_': '/tools/buildbot/bin/python'} 02:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 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)) 02:39:16 INFO - Cleaning up... 02:39:16 INFO - Return code: 0 02:39:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 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 0x7f81073acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, '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-1481711915.68342-1868818991', '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 02:39:16 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 02:39:16 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 02:39:16 INFO - Using env: {'DISPLAY': ':0', 02:39:16 INFO - 'HOME': '/home/cltbld', 02:39:16 INFO - 'LANG': 'en_US.UTF-8', 02:39:16 INFO - 'LANGUAGE': 'en_US:en', 02:39:16 INFO - 'LOGNAME': 'cltbld', 02:39:16 INFO - 'MAIL': '/var/mail/cltbld', 02:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:16 INFO - 'MOZ_NO_REMOTE': '1', 02:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:16 INFO - 'NO_EM_RESTART': '1', 02:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:16 INFO - 'PWD': '/builds/slave/test', 02:39:16 INFO - 'SHELL': '/bin/bash', 02:39:16 INFO - 'SHLVL': '1', 02:39:16 INFO - 'TERM': 'linux', 02:39:16 INFO - 'TMOUT': '86400', 02:39:16 INFO - 'USER': 'cltbld', 02:39:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:16 INFO - '_': '/tools/buildbot/bin/python'} 02:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:16 INFO - Cleaning up... 02:39:16 INFO - Return code: 0 02:39:16 INFO - Running post-action listener: _resource_record_post_action 02:39:16 INFO - Running post-action listener: _start_resource_monitoring 02:39:16 INFO - Starting resource monitoring. 02:39:16 INFO - [mozharness: 2016-12-14 10:39:16.632689Z] Finished create-virtualenv step (success) 02:39:16 INFO - [mozharness: 2016-12-14 10:39:16.633148Z] Running install step. 02:39:16 INFO - Running pre-action listener: _resource_record_pre_action 02:39:16 INFO - Running main action method: install 02:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:16 INFO - Reading from file tmpfile_stdout 02:39:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:16 INFO - Reading from file tmpfile_stdout 02:39:16 INFO - Output received: 02:39:16 INFO - Usage: mozinstall [options] installer 02:39:16 INFO - Options: 02:39:16 INFO - -h, --help show this help message and exit 02:39:16 INFO - -d DEST, --destination=DEST 02:39:16 INFO - Directory to install application into. [default: 02:39:16 INFO - "/builds/slave/test"] 02:39:16 INFO - --app=APP Application being installed. [default: firefox] 02:39:16 INFO - mkdir: /builds/slave/test/build/application 02:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:39:32 INFO - Reading from file tmpfile_stdout 02:39:32 INFO - Output received: 02:39:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:32 INFO - Running post-action listener: _resource_record_post_action 02:39:32 INFO - [mozharness: 2016-12-14 10:39:32.865328Z] Finished install step (success) 02:39:32 INFO - [mozharness: 2016-12-14 10:39:32.865572Z] Running run-tests step. 02:39:32 INFO - Running pre-action listener: _resource_record_pre_action 02:39:32 INFO - Running main action method: run_tests 02:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:32 INFO - Python 2.7.3 02:39:32 INFO - Return code: 0 02:39:32 INFO - grabbing minidump binary from tooltool 02:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9af60>, '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 0x2c9bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:39:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:39:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:39:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:32 INFO - Return code: 0 02:39:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:39:32 INFO - Using env: {'DISPLAY': ':0', 02:39:32 INFO - 'HOME': '/home/cltbld', 02:39:32 INFO - 'LANG': 'en_US.UTF-8', 02:39:32 INFO - 'LANGUAGE': 'en_US:en', 02:39:32 INFO - 'LOGNAME': 'cltbld', 02:39:32 INFO - 'MAIL': '/var/mail/cltbld', 02:39:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:32 INFO - 'MOZ_NO_REMOTE': '1', 02:39:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:32 INFO - 'NO_EM_RESTART': '1', 02:39:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:32 INFO - 'PWD': '/builds/slave/test', 02:39:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:32 INFO - 'SHELL': '/bin/bash', 02:39:32 INFO - 'SHLVL': '1', 02:39:32 INFO - 'TERM': 'linux', 02:39:32 INFO - 'TMOUT': '86400', 02:39:32 INFO - 'USER': 'cltbld', 02:39:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1481711915.68342-1868818991', 02:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:32 INFO - '_': '/tools/buildbot/bin/python'} 02:39:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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 02:39:33 INFO - mozversion application_buildid: 20161214005401 02:39:33 INFO - mozversion application_changeset: 450277eb1728b1ac8843f684d0a1474462d91c6d 02:39:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:39:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:33 INFO - mozversion application_name: Firefox 02:39:33 INFO - mozversion application_remotingname: firefox-dev 02:39:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:33 INFO - mozversion application_vendor: Mozilla 02:39:33 INFO - mozversion application_version: 52.0a2 02:39:33 INFO - mozversion platform_buildid: 20161214005401 02:39:33 INFO - mozversion platform_changeset: 450277eb1728b1ac8843f684d0a1474462d91c6d 02:39:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:33 INFO - mozversion platform_version: 52.0a2 02:39:33 INFO - using testdate: 1481711973 02:39:33 INFO - actual date: 1481711973 02:39:33 INFO - starting webserver on 'localhost:42167' 02:39:33 INFO - SUITE-START | Running 2 tests 02:39:33 INFO - TEST-START | dromaeo_css 02:39:33 INFO - operating with platform_type : linux_ 02:39:33 INFO - Initialising browser for dromaeo_css test... 02:39:33 INFO - TEST-INFO | started process 11218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGpfZVK/profile http://localhost:42167/getInfo.html) 02:39:37 INFO - PROCESS | 11218 | __metrics Screen width/height:1600/1200 02:39:37 INFO - PROCESS | 11218 | colorDepth:24 02:39:37 INFO - PROCESS | 11218 | Browser inner width/height: 1024/697 02:39:37 INFO - PROCESS | 11218 | __metrics 02:39:37 INFO - PROCESS | 11218 | 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" 02:39:37 INFO - PROCESS | 11218 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:38 INFO - PROCESS | 11218 | console.error: PushService: 02:39:38 INFO - PROCESS | 11218 | stateChangeProcessEnqueue: Error transitioning state 02:39:38 INFO - PROCESS | 11218 | UnknownError 02:39:38 INFO - TEST-INFO | 11218: exit 0 02:39:38 INFO - Browser initialized. 02:39:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:38 INFO - TEST-INFO | started process 11308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGpfZVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:50 INFO - PROCESS | 11308 | RSS: Main: 144236544 02:39:50 INFO - PROCESS | 11308 | 02:40:41 INFO - PROCESS | 11308 | 1481712041806 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] 02:42:52 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42167/tests/dromaeo/cssquery-ext.html) 02:42:53 INFO - PROCESS | 11308 | RSS: Main: 247472128 02:42:53 INFO - PROCESS | 11308 | 02:45:56 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-ext.html (next: http://localhost:42167/tests/dromaeo/cssquery-jquery.html) 02:45:56 INFO - PROCESS | 11308 | RSS: Main: 239198208 02:45:56 INFO - PROCESS | 11308 | 02:48:58 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42167/tests/dromaeo/cssquery-mootools.html) 02:48:59 INFO - PROCESS | 11308 | RSS: Main: 222998528 02:48:59 INFO - PROCESS | 11308 | 02:52:01 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42167/tests/dromaeo/cssquery-prototype.html) 02:52:01 INFO - PROCESS | 11308 | RSS: Main: 204976128 02:52:01 INFO - PROCESS | 11308 | 02:55:04 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42167/tests/dromaeo/cssquery-yui.html) 02:55:05 INFO - PROCESS | 11308 | RSS: Main: 179384320 02:55:05 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:42167/tests/dromaeo/cssquery-yui.html (next: http://localhost:42167/tests/dromaeo/cssquery-dojo.html) 02:58:07 INFO - PROCESS | 11308 | RSS: Main: 268525568 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | __start_tp_report 02:58:07 INFO - PROCESS | 11308 | _x_x_mozilla_page_load 02:58:07 INFO - PROCESS | 11308 | _x_x_mozilla_page_load_details 02:58:07 INFO - PROCESS | 11308 | |i|pagename|runs| 02:58:07 INFO - PROCESS | 11308 | |0;dojo.html;3187.5696780934572;3209.903702888913;3228.1122691259916;3250.431174544457;3270.9182270443252;5572.60991730579;5665.150227465882;5676.574256930737;5690.544756419492;5703.572232082595;5621.831345059644;5681.177357134655;5697.658140511572;5703.800366987156;5722.113072473763;5097.898042039166;5129.179331306992;5146.716930568836;5158.252053452247;5194.506521880416;5009.599232061426;5009.699418034911;5104.132297509414;5245.816396426126;5268.446813084628;5103.668261563005;5234.6335756497065;5246.1606143017125;5247.396549396811;5249.1338929076655;5242.9213561796605;5248.711320877369;5253.921191182136;5260.894782104375;5293.23248129023;4863.1732605457155;4954.43024052235;5153;5162.819301324435;5219.765110570033;5529.723513824333;5567.805126820583;5568.49883510482;5611;5626.409227031144;5989.161517387569;5995.130706047598;6034.939650603482;6089.725962331661;6097.756089756404;5735.684537350444;6101.969490152565;6110.114033465167;6118.877622447526;6121.265448146207;5394.811181608625;5557.472040156179;5607.803726869581;5637.7181140942785;5706;6112.877742445126;6134.38656134383;6135.294441139237;6138.048602466535;6145.324014358417;5748.511376532958;5940.6435613863305;5944.64332140073;5949.1076338549565;5954.374790647006;5877.294724633071;5963.403659634002;6024;6028.09578563219;6130.29501607312;5989.221401217814;6030.517558595389;6044.879102417927;6054.212952316258;6056.454919057306;6060.151578778975;6061.424164704346;6062.969685151546;6073.210482637229;6087.9391206087375;4468.597826195658;4496.572825581565;4616.492185859553;4646.09401166776;4649.86050418488;4143.02638879863;4158.604932531404;4169.45797046382;4188.308929026737;4193.895152621148;5712.285964254468;5715.742791574389;5716.485516303553;5719.828405147852;5721.313442386941;5826.41735826414;5877.52979761618;5906.3207731110615;5924;6115.388461153849;5613.382527921925;5620.522255608319;5624.803131890364;5635.295588051494;5656.717164141776;5138.023775482647;5139.254808052886;5140.049090918192;5147.6654017488745;5174.767135478913;5894.263217097863;6016.488598469179;6047.879042419215;6101.694915254308;6111.694415279218;5943.227380440515;6019.036954087325;6022.337542870193;6045.727942242522;6051.4553690168095;6150.261968563801;6177.938220617736;6185.721642526007;6189.473894718819;6191.84520386994;5667.036603777286;5674.631148975303;5936.37668044849;5942.405759424023;5945.10823376497;6034.577579569388;6071.332153463204;6074.0281554951;6141.1310874149;6145.279321789906;5946.851328716817;5997.340292567901;5997.760089596542;6004.279486461653;6026.638401695912;5635.492805647511;5974.044152935509;5980.5215582754145;5984.431479009487;5985.880282394241;5695.544356451557;5706.9714651426475;5748.223989761496;5748.856278592902;5847.912281315868;5886.676232807065;5910.202122713378;5912.556558258234;5914.526837853047;5915.970420147872;5521.806736764194;5552.972235138798;5563.02647036775;5762.1644861494015;5762.798302059407 02:58:07 INFO - PROCESS | 11308 | |1;ext.html;562.8086450606794;582.1384351160283;599.8620317327014;602.3524710935742;605.657803341112;33381.66618333816;44792.552074479245;46372;46569;49331;47684.28473572891;48264;48349.274760878616;48411.75794121033;48412.51587484124;8272.090070092285;8850.73447796567;8993.190612844875;8993.28053755698;9009.819803603925;8230.42387032908;8544.914550854504;8547.572621368938;10543.31468454548;10847.349159050444;10908.672739817817;10961.397123158264;10962.068224200952;10969.670909872677;10974.615888443906;10656;10664;10687.732806679818;10702.732431689192;10718.999999999962;10706.946465267623;10775;10788.244822862403;10791.892081079168;10799.2440529163;44585;44776.3283550747;44959.550404495865;44964.77517612391;44965;3674.879161855633;3781.810909454516;3880.1657643606477;3912.4131380292897;4207.474065741782;33951.15122121967;33971;34116.48825267623;34191.145221369414;34236.657633423594;4532;4594.081183763261;4620.237660785966;4723.291506274052;4724.267738500538;359245;360357;361736;362072;363173;65141.348586514476;65333;65356.346436535976;65426.345736542025;65440.67279663667;40327;41194.38208426876;41470.1705965879;69748.30251697417;69841.65079174572;15970.60073498172;16216.270267837976;16234.75647865283;16244.431444899608;16265.51203463898;10732.356058636507;12951;13082.934585327203;13105.475780968654;13183.077184596987;18259.72610410845;19556.132511171523;21513.462163445725;21514.247001354877;21531.569368612854;7195.820104497429;7235.2764723527225;7301;7424.290134101014;7455.85088298231;996.2080146283722;1070.8233141531716;1094.9014588687057;1154.4112502623723;1190.3691043746828;34307.313853722786;34894.476582851275;35112.54530899612;35150.824245878604;35259.294814103574;1151.3840095548842;1228.5638598297655;1243.1795015290047;1245.5578269714122;1258.2324781883044;17241.793074484918;17966.820331796775;17973.460796176136;18015.099245037694;18029;540908;616165;625227;625684;918460;62750.686246568475;63514.36485635177;63616;63726.36273637297;63806.6809665958;1248.950041998328;1333.7399207154706;1389.208151353739;1431.2628996067033;1459.7080583883053;31144.53283200799;34829.30341393209;37430.251394972496;37448;37489.812550938164;59808.401915982024;60768.78462430815;60794.08808867782;60808.695956519936;60826.695866520386;511432;515851;516135;516710;518002;28262.85868570644;29198.854005729834;29459.705402945696;30930.226744331572;32145.196370090936;48997;49806.75096624494;50584.747076264386;50594;51530;42614.57385426106;43659.781701092565;44011.77994110009;44391.33412998743;44869.55130448654;43537;44416;44733.105337893714;44871;45364.54635453735;39049.804750976065;39656;43270;44388.33417498805;44563;36964.815175925025;39601.207975840895;40028.39957400583;40217.79891100526;40474.797626011685;29578.556321654763;29689.406211876074;29967.850160749058;30202;30240.185588864737 02:58:07 INFO - PROCESS | 11308 | |2;jquery.html;422.08197171152733;427.3354933079062;429.3208836694422;435.45568039950064;441.97348159110453;18423.263069477223;18918.90540547297;20294;20321.390358289256;20463.079161437734;18877.71683424746;19063.142158602863;19268.3256086037;19282.51793705158;19429.708554371697;5568.554515638739;5815.273090863642;5824.825255242328;5825.796097136601;5832.825015249549;5528.723563821813;5629.380768115504;5709.600327977043;5711.171880077386;5757.539396848242;5756.02147634903;5757.99235133852;5759.798407055754;5764.308283006024;5765.1928729977835;5547.195656629786;5633.6619802811965;5688.658680479184;5757.078867381219;5760.164776107462;5080.568151707109;5083.339165908408;5084;5087.720175390352;5089.898202035975;22792.202272920367;23131.421714457105;23142.7685723144;23168.420789480228;23314.06743730249;2131.1262382423133;2271.4775601611723;2394.078279862248;2408.6146216605257;2654.9469010619873;14161.504347347896;14515.564533064025;14643.780343294859;14698.632534186623;15173.924130379277;1868.4021113243768;2032.7662318833375;2045.1001559313854;2097.5070858348276;2125.1286972341422;55528.26776791976;60632.39367606312;76596;82099;85054.14945850585;10185.796284074277;10361.74095647615;10518.263721539419;10786.568537258421;11356.318620882608;16034.839651603568;16045.277962491717;16062.116583587782;16062.43781467643;16087.276072576762;7929;8101.675932962733;8146.9592652037545;8163.510189388656;8342.749717508485;7616.314531692175;7661.61691915402;7682.692692292358;7918.326942209977;7922;6695.46436285096;6802.14973128359;6829.897551536731;6883.552569083094;7003.859922801617;1969.4780883065998;2045.818751840872;2063.515073957619;2072.171131547363;2139.5720855828895;814.4380377539479;930.2650905784354;1074.258761454594;1076.4617691154422;1136.1649187846926;19381.90309048446;19409.51476213106;19544.51138721515;19626.607467850565;19828.405147845588;1031.9587216511406;1039.2257767962765;1053.3995622495258;1060.7136073260176;1064.41989115932;10630.415327156927;11524.135689823297;11563.595274165364;11642.185047046625;11666.300021998708;494119;496194;506802;507971;511493;84017;86893.56553217194;87130;88523;88786;1049.3074570783247;1050.4852622215212;1051.9789604207872;1054.7732237568805;1081.1783044885785;17388.043657598446;17440.127993600014;18010.279588816302;18030.1886415109;18260.817391825913;41836.79081604572;41917.79041104775;42010.579894200666;42540.57459425366;43505.34741978936;54546.18180727213;55088.44911550833;55586.44413555813;55894;57156.142192889354;8398.538080405637;8475.788105297417;8769.38614296993;8994.595243214202;9071.909280907106;12309.384530773605;12546.184498007966;12879.356032198166;13057.673558161123;13396.732065358443;6972.884338505814;9941.105300522988;11556.364399958084;11587.130965177477;11767.88232117668;5457.399686034612;8688.478691278544;11031.455596216696;11072.667819965414;11174;11253.831192531954;11269.774604508028;11343.262687925258;11490.253133546294;12064.577739779066;7445.553266804009;8132.227438393344;8150.510969341858;8420.957895210484;8846.513441760764;9364.391314564531;11982.281063136239;12082.818757718465;12142.39288035577;12359.25844449336 02:58:07 INFO - PROCESS | 11308 | |3;mootools.html;1520.733871572475;1539.753639417693;1678.16091954023;1785.348347853034;1833.8807977481463;8637.352198585108;9164.175224229817;9166.495842728647;9176.17414432701;9191.310651701124;7875.409344299186;8119.837603247932;8527.445716028455;8760.211580957712;8959.776005599862;2516.232549072532;2550.1839411388364;2555.974440255592;2557.3734435063434;2558.577834657289;2366.1008816649737;2418.0811291709124;2438.0491608272787;2442.9389265268333;2444.10790061628;2508.046942161976;2511.1211076123395;2516.8112391570708;2519.6472493850874;2527.772500474957;2435.464197876473;2463.2117722328862;2484.1181380609983;2487.2911220302217;2491.202815099169;2486.813488988333;2493.650888875559;2515.748425157488;2517.093846215361;2518.987405062963;8979.281657467453;9009.144131307516;9092.136247056518;9092.590833412512;9106.544672766335;5599.860003499945;5734.684592347419;5736.2256095427;5743.655380677131;5744.798932037401;3609.097725568608;3659.505966694489;3681.7975011374365;3759.9436008459893;3848.5958974307855;1257.076049103908;1266.1263728027723;1279.1174089878048;1297.4161627267767;1325.9270740109291;12810.29543375114;12860.549880754128;12885.549005784753;12902.54841080567;12987.025973051965;4975.328330675313;5095.471358592482;5274.446183150791;5276.947230527646;5294.682319060868;10825.188110891715;10845.07816835562;10846.240763146505;10849.78300433987;10860.076893463985;5789.247397838339;5791.797287095016;5794.333651630032;5794.362620111784;5795.304563452412;4359.629431498358;5092.516210959953;5147.845564633067;5210.244514545446;5239.816606418757;4145.398917156996;4185.602367775056;4211.684123690736;4241.427407300037;4247.893802654959;1357.362039841273;1406.4444544405108;1408.1621435246013;1416.044170185121;1420.2472689474596;982.1160955140431;998.8152191844532;1005.1550235381235;1005.9647912323034;1014.6702321745462;5789.797357092481;5975.492083172892;6012.879742405127;6060.484858787053;6260.436560709558;478.4234996828813;489.81387072912065;490.17650347416685;491.59197865771324;497.41553674432396;4031.576684448091;4151.4395556600075;4159.209750147463;4203.201391735561;4276.72201306914;10984.505697243643;11392.886071139183;11455.198136130392;11511.654650360502;11536.365499897585;11268.323900565993;11314.151438642135;11353;11396.430178491042;11408.144389170846;8083.878741818878;8387.706430274911;8433.451825631315;8458.407911446262;8528.147185281547;6116.217121209927;6329.430351268408;6342.651154186564;6357.364263573606;6360.618362898241;10260.743481413025;10292.845607315747;10412.583496660049;10417.635382761568;10462.424566648602;10240.948795255976;10343.741406464898;10432.947835261079;10554.894451055698;10633;7304.306090921354;7576.4317676173405;7862.2923936845955;8185.4270201085355;8334.20825021622;8882.15619516145;8947.507887066275;8955.731328060168;8961.193492585699;8962.73111806647;7652.961735191511;7859.685612575661;7886.329661978796;7893.684252629831;7919.16848730875;7735.9226407735205;7837.41219408558;7853.882191767242;7860.331871790733;8062.516249025077;7126.429885609243;7205.027321311556;7213.134423869169;7227.385672217921;7323.780286591411;5335.546478549367;5356.303680521507;5439.347278326626;5509.779608815763;5536.169574563848;5535.640183388067;5540.722963851711;5601.075822489406;5638.097904335286;5724.484796368347 02:58:07 INFO - PROCESS | 11308 | |4;prototype.html;344.2907610322735;354.97870127792334;358.6628569145002;359.148817302992;362.44183956706667;5438.700871452069;5455.699936503491;5519.448055194479;5529.308836395446;5584.134459158832;5162.6644268122545;5198.636095473309;5257.739172155972;5262.9473705262935;5462.426445223244;4246.171996460692;4257.233697934378;4262.360645903108;4268;4285.571442855705;4279.2083464559155;4316.352547117926;4335.978320108395;4339.9819084125875;4365.759883206422;3971.8808435746973;4005.5794141615147;4275.05948691289;4275.700700950934;4289.678274129437;4264.87205383839;4265.936010959838;4274.615284624383;4277.593628605277;4282.935755963647;3853.0560012797046;3854.8843534693724;3864.9613503864884;3871.4386413970096;3876.8449262029485;5105.361829771278;5187.533122018998;5231.267622532849;5237.16205407133;5244.344456942882;4924.630652701026;4929;4932.358793356877;4936.876578085541;4939.259111133323;5620.297462817148;5640.09758438652;5647.915281270784;5652.689102099383;5675.871548169436;4141.213169497786;4227.598378154071;4240.300350442204;4248.87253382399;4257.659387249013;5766.913496297559;5778.930897783924;5807.2160258365;5813.302403711539;5837.50381217597;4321.308590625485;4324.978375108104;4326.394304797331;4340.305551111807;4351.43431353922;4009.4186342980106;4187.371894215892;4212.768297743653;4415.315626077963;4419.580139886705;4753.47711751707;4754.23932170851;4758.476567577563;4779.545943135397;4795.544423279783;5591.329040515164;5624.578156638268;5644.322681278273;5649.350324712628;5652.660840349592;1382.4401117547409;1427.978580321296;1430.5708287513705;1438.7266419380285;1444.2850788859582;930.3952430919957;953.9379940303996;981.8821741390936;991.1525645573075;1006.8993100690019;5152.92270615941;5165.819196328111;5167.896642067213;5233.398159211663;5237.831112177078;5532.478568393643;5566.165075238747;5568.805091821767;5575.972120139373;5583.274174357308;5185.522126194017;5186.948130518722;5420.728963551806;5444.455554444524;5472.179173123984;2944.0284706046955;2959.926001849971;2971.539411391238;2971.9108426747234;2976.4493568689427;5489.862753431196;5698.515626171739;5723.828285151452;5730.226419433407;5741.368449470555;5667.574931880043;5670.432956704297;5710.457506536873;5719.227904232958;5769.134629805562;5693.459121383462;5711.171880077449;5711.771529138788;5734.111212761945;5737.483626473638;5433.701146436984;5463.371712253142;5541.3904470509015;5548.334199896039;5638.436156384493;5513.641613295123;5543.341394679493;5588.552915766811;5596.516923015485;5620.74706638194;5492.148716948879;5721.882903325796;5765.538756899354;5798.594098413239;5800.24596802413;3988.980055099706;4024.665693897591;4027.4361589376927;4043.534993475788;4047.332190188586;5614.9719251403485;5621.381648018796;5626.774929002958;5643.746031428514;5649.971750141387;5386.649867758583;5491.780328786964;5523.784767351176;5532.419095994863;5533.861653458695;5412.319622656474;5416.620836541404;5436.40199578054;5471.863203419946;5474.671519708831;5411.945880541144;5414.7021913795115;5416.431274716256;5441.809536666197;5537.916931246115;5450.5367043801725;5618.943810561842;5709.571782116275;5709.771609135588;5711;5484.149956756709;5575.77696892136;5577.804776832953;5578.163275508706;5596.356419011866 02:58:07 INFO - PROCESS | 11308 | |5;yui.html;757.821911850715;764.4419573711187;767.0948281028387;785.065771731639;786.9921300786992;12540.749185016295;12930.094893357456;12937.223766574012;12948.611541653765;12949.546765863197;13474.730505389887;13693.93153034236;13697.520586779465;13703.58889233322;13723;708.7802781137838;727.6834576959039;813.1786895235825;834.9624266908004;840.0255703384075;845.9069502354766;846.8094678697305;853.1085016158098;853.63293783673;853.9231469167773;897.107378158733;898.5103118800237;899.0245583541865;899.2086963472135;899.3749344205779;732.8167958010497;881.3830318776818;893.5621545442718;893.7184786792172;893.9106089391074;560.2548610348268;621.6456619726757;632.9936700633027;638.7572722365518;640.679660169915;12675.873241267562;12683.556075537404;12708.745825083539;12718.618441446772;12725.681857953532;12817.487300507968;12926.159799612995;13368.732625347537;13459.730805383935;13588.405566837351;10886.72783180419;10931.945340273327;11123.16576256784;11348.829767553494;11382.260153090023;4191.2395653014955;4199.307114326132;4224.345226489899;4238.978805105986;4254.468191476066;63897.680511597144;65547.67226163886;65576;65611.67194164047;65848.34151658518;10245.948770256102;10441.895581044093;10486.737831554272;10706.304090234109;10911.23621346514;17762.37831675885;17765.644687106185;17768.91115544414;17802.46592602224;17836.55408614769;7601.923980760122;7632.389408847279;7640.083190017233;7666.271704188205;8187.38594605407;4340.978295108567;4343.500497442771;4387.232234358974;4444.28891377378;4489.775511224426;3319.1204330852343;3416.3850506908498;3429.7427692922633;3444.689977901951;3491.7730347527836;588.6909372579345;594.3343455329972;595.9165716799652;602.193061297863;618.7896115320813;582.8249694486905;600.4355905448864;649.9252585952581;681.3969636871306;681.5331497923938;8468.32253419725;8629.827403452022;8631.438956467935;8951.194392504705;9037;597.8624916269282;659.4295934017041;690.8860038093658;712.8004158835535;726.1286456252412;4115.303723864901;4233.8518151865155;4283.571642835754;4295.334223195409;4382.474103107584;87224.5638771802;91483;92488;92911;94371.52814235885;51347.48652513502;64558;80546.59726701329;80976;81897;73036.63481682558;73661;74678.25321746821;75179.99280028738;75666.62166689131;8223.588820558829;8340.541270230196;8359.289460395934;8629.43908645936;8660.62235728054;44819.879503012686;45653;46157.538424615326;46648.30027549657;47092.76453617847;62485.375146247956;63796.68101659462;63835.6808215956;65314.34685653083;65491.34508654852;10910.563577456813;11035.227534072537;11207.271527350696;11595.13036522281;12148.939255303667;12699.682507937376;13258.602241932758;13363.599092027254;13398.732025359242;13431.798523022358;10641.946790266;12619.49522019109;12711.110222284722;13125.868741312846;13278.601641950758;11298.43507824589;11455;11667.124965627441;11930.463129159036;12285.385730713608;12829;12901.870981290067;13019.544315948897;13134.671633209246;13665.437205389657;10179.185665146622;10459.267851250339;10614.628488002883;10811.891881081403;10897.564097436014;10286.691399258034;10567.63013294531;10912.127029837753;11082.889171108185;11275 02:58:07 INFO - PROCESS | 11308 | __end_tp_report 02:58:07 INFO - PROCESS | 11308 | __start_cc_report 02:58:07 INFO - PROCESS | 11308 | _x_x_mozilla_cycle_collect,1034 02:58:07 INFO - PROCESS | 11308 | __end_cc_report 02:58:07 INFO - PROCESS | 11308 | __startTimestamp1481713087862__endTimestamp 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | ------- Summary: start ------- 02:58:07 INFO - PROCESS | 11308 | Number of tests: 6 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#0] dojo.html Cycles:165 Average:5585.15 Median:5722.11 stddev:626.92 (11.0%) stddev-sans-first:599.97 02:58:07 INFO - PROCESS | 11308 | Values: 3187.6 3209.9 3228.1 3250.4 3270.9 5572.6 5665.2 5676.6 5690.5 5703.6 5621.8 5681.2 5697.7 5703.8 5722.1 5097.9 5129.2 5146.7 5158.3 5194.5 5009.6 5009.7 5104.1 5245.8 5268.4 5103.7 5234.6 5246.2 5247.4 5249.1 5242.9 5248.7 5253.9 5260.9 5293.2 4863.2 4954.4 5153.0 5162.8 5219.8 5529.7 5567.8 5568.5 5611.0 5626.4 5989.2 5995.1 6034.9 6089.7 6097.8 5735.7 6102.0 6110.1 6118.9 6121.3 5394.8 5557.5 5607.8 5637.7 5706.0 6112.9 6134.4 6135.3 6138.0 6145.3 5748.5 5940.6 5944.6 5949.1 5954.4 5877.3 5963.4 6024.0 6028.1 6130.3 5989.2 6030.5 6044.9 6054.2 6056.5 6060.2 6061.4 6063.0 6073.2 6087.9 4468.6 4496.6 4616.5 4646.1 4649.9 4143.0 4158.6 4169.5 4188.3 4193.9 5712.3 5715.7 5716.5 5719.8 5721.3 5826.4 5877.5 5906.3 5924.0 6115.4 5613.4 5620.5 5624.8 5635.3 5656.7 5138.0 5139.3 5140.0 5147.7 5174.8 5894.3 6016.5 6047.9 6101.7 6111.7 5943.2 6019.0 6022.3 6045.7 6051.5 6150.3 6177.9 6185.7 6189.5 6191.8 5667.0 5674.6 5936.4 5942.4 5945.1 6034.6 6071.3 6074.0 6141.1 6145.3 5946.9 5997.3 5997.8 6004.3 6026.6 5635.5 5974.0 5980.5 5984.4 5985.9 5695.5 5707.0 5748.2 5748.9 5847.9 5886.7 5910.2 5912.6 5914.5 5916.0 5521.8 5553.0 5563.0 5762.2 5762.8 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#1] ext.html Cycles:180 Average:67895.99 Median:40123.10 stddev:142638.50 (355.5%) stddev-sans-first:142949.05 02:58:07 INFO - PROCESS | 11308 | Values: 562.8 582.1 599.9 602.4 605.7 33381.7 44792.6 46372.0 46569.0 49331.0 47684.3 48264.0 48349.3 48411.8 48412.5 8272.1 8850.7 8993.2 8993.3 9009.8 8230.4 8544.9 8547.6 10543.3 10847.3 10908.7 10961.4 10962.1 10969.7 10974.6 10656.0 10664.0 10687.7 10702.7 10719.0 10706.9 10775.0 10788.2 10791.9 10799.2 44585.0 44776.3 44959.6 44964.8 44965.0 3674.9 3781.8 3880.2 3912.4 4207.5 33951.2 33971.0 34116.5 34191.1 34236.7 4532.0 4594.1 4620.2 4723.3 4724.3 359245.0 360357.0 361736.0 362072.0 363173.0 65141.3 65333.0 65356.3 65426.3 65440.7 40327.0 41194.4 41470.2 69748.3 69841.7 15970.6 16216.3 16234.8 16244.4 16265.5 10732.4 12951.0 13082.9 13105.5 13183.1 18259.7 19556.1 21513.5 21514.2 21531.6 7195.8 7235.3 7301.0 7424.3 7455.9 996.2 1070.8 1094.9 1154.4 1190.4 34307.3 34894.5 35112.5 35150.8 35259.3 1151.4 1228.6 1243.2 1245.6 1258.2 17241.8 17966.8 17973.5 18015.1 18029.0 540908.0 616165.0 625227.0 625684.0 918460.0 62750.7 63514.4 63616.0 63726.4 63806.7 1249.0 1333.7 1389.2 1431.3 1459.7 31144.5 34829.3 37430.3 37448.0 37489.8 59808.4 60768.8 60794.1 60808.7 60826.7 511432.0 515851.0 516135.0 516710.0 518002.0 28262.9 29198.9 29459.7 30930.2 32145.2 48997.0 49806.8 50584.7 50594.0 51530.0 42614.6 43659.8 44011.8 44391.3 44869.6 43537.0 44416.0 44733.1 44871.0 45364.5 39049.8 39656.0 43270.0 44388.3 44563.0 36964.8 39601.2 40028.4 40217.8 40474.8 29578.6 29689.4 29967.9 30202.0 30240.2 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#2] jquery.html Cycles:180 Average:29052.86 Median:2401.35 stddev:82661.91 (3442.3%) stddev-sans-first:82865.85 02:58:07 INFO - PROCESS | 11308 | Values: 422.1 427.3 429.3 435.5 442.0 18423.3 18918.9 20294.0 20321.4 20463.1 18877.7 19063.1 19268.3 19282.5 19429.7 5568.6 5815.3 5824.8 5825.8 5832.8 5528.7 5629.4 5709.6 5711.2 5757.5 5756.0 5758.0 5759.8 5764.3 5765.2 5547.2 5633.7 5688.7 5757.1 5760.2 5080.6 5083.3 5084.0 5087.7 5089.9 22792.2 23131.4 23142.8 23168.4 23314.1 2131.1 2271.5 2394.1 2408.6 2654.9 14161.5 14515.6 14643.8 14698.6 15173.9 1868.4 2032.8 2045.1 2097.5 2125.1 55528.3 60632.4 76596.0 82099.0 85054.1 10185.8 10361.7 10518.3 10786.6 11356.3 16034.8 16045.3 16062.1 16062.4 16087.3 7929.0 8101.7 8147.0 8163.5 8342.7 7616.3 7661.6 7682.7 7918.3 7922.0 6695.5 6802.1 6829.9 6883.6 7003.9 1969.5 2045.8 2063.5 2072.2 2139.6 814.4 930.3 1074.3 1076.5 1136.2 19381.9 19409.5 19544.5 19626.6 19828.4 1032.0 1039.2 1053.4 1060.7 1064.4 10630.4 11524.1 11563.6 11642.2 11666.3 494119.0 496194.0 506802.0 507971.0 511493.0 84017.0 86893.6 87130.0 88523.0 88786.0 1049.3 1050.5 1052.0 1054.8 1081.2 17388.0 17440.1 18010.3 18030.2 18260.8 41836.8 41917.8 42010.6 42540.6 43505.3 54546.2 55088.4 55586.4 55894.0 57156.1 8398.5 8475.8 8769.4 8994.6 9071.9 12309.4 12546.2 12879.4 13057.7 13396.7 6972.9 9941.1 11556.4 11587.1 11767.9 5457.4 8688.5 11031.5 11072.7 11174.0 11253.8 11269.8 11343.3 11490.3 12064.6 7445.6 8132.2 8150.5 8421.0 8846.5 9364.4 11982.3 12082.8 12142.4 12359.3 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#3] mootools.html Cycles:180 Average:6039.01 Median:490.00 stddev:3391.86 (692.2%) stddev-sans-first:3384.37 02:58:07 INFO - PROCESS | 11308 | Values: 1520.7 1539.8 1678.2 1785.3 1833.9 8637.4 9164.2 9166.5 9176.2 9191.3 7875.4 8119.8 8527.4 8760.2 8959.8 2516.2 2550.2 2556.0 2557.4 2558.6 2366.1 2418.1 2438.0 2442.9 2444.1 2508.0 2511.1 2516.8 2519.6 2527.8 2435.5 2463.2 2484.1 2487.3 2491.2 2486.8 2493.7 2515.7 2517.1 2519.0 8979.3 9009.1 9092.1 9092.6 9106.5 5599.9 5734.7 5736.2 5743.7 5744.8 3609.1 3659.5 3681.8 3759.9 3848.6 1257.1 1266.1 1279.1 1297.4 1325.9 12810.3 12860.5 12885.5 12902.5 12987.0 4975.3 5095.5 5274.4 5276.9 5294.7 10825.2 10845.1 10846.2 10849.8 10860.1 5789.2 5791.8 5794.3 5794.4 5795.3 4359.6 5092.5 5147.8 5210.2 5239.8 4145.4 4185.6 4211.7 4241.4 4247.9 1357.4 1406.4 1408.2 1416.0 1420.2 982.1 998.8 1005.2 1006.0 1014.7 5789.8 5975.5 6012.9 6060.5 6260.4 478.4 489.8 490.2 491.6 497.4 4031.6 4151.4 4159.2 4203.2 4276.7 10984.5 11392.9 11455.2 11511.7 11536.4 11268.3 11314.2 11353.0 11396.4 11408.1 8083.9 8387.7 8433.5 8458.4 8528.1 6116.2 6329.4 6342.7 6357.4 6360.6 10260.7 10292.8 10412.6 10417.6 10462.4 10240.9 10343.7 10432.9 10554.9 10633.0 7304.3 7576.4 7862.3 8185.4 8334.2 8882.2 8947.5 8955.7 8961.2 8962.7 7653.0 7859.7 7886.3 7893.7 7919.2 7735.9 7837.4 7853.9 7860.3 8062.5 7126.4 7205.0 7213.1 7227.4 7323.8 5335.5 5356.3 5439.3 5509.8 5536.2 5535.6 5540.7 5601.1 5638.1 5724.5 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#4] prototype.html Cycles:180 Average:4706.31 Median:5415.57 stddev:1342.49 (24.8%) stddev-sans-first:1305.73 02:58:07 INFO - PROCESS | 11308 | Values: 344.3 355.0 358.7 359.1 362.4 5438.7 5455.7 5519.4 5529.3 5584.1 5162.7 5198.6 5257.7 5262.9 5462.4 4246.2 4257.2 4262.4 4268.0 4285.6 4279.2 4316.4 4336.0 4340.0 4365.8 3971.9 4005.6 4275.1 4275.7 4289.7 4264.9 4265.9 4274.6 4277.6 4282.9 3853.1 3854.9 3865.0 3871.4 3876.8 5105.4 5187.5 5231.3 5237.2 5244.3 4924.6 4929.0 4932.4 4936.9 4939.3 5620.3 5640.1 5647.9 5652.7 5675.9 4141.2 4227.6 4240.3 4248.9 4257.7 5766.9 5778.9 5807.2 5813.3 5837.5 4321.3 4325.0 4326.4 4340.3 4351.4 4009.4 4187.4 4212.8 4415.3 4419.6 4753.5 4754.2 4758.5 4779.5 4795.5 5591.3 5624.6 5644.3 5649.4 5652.7 1382.4 1428.0 1430.6 1438.7 1444.3 930.4 953.9 981.9 991.2 1006.9 5152.9 5165.8 5167.9 5233.4 5237.8 5532.5 5566.2 5568.8 5576.0 5583.3 5185.5 5186.9 5420.7 5444.5 5472.2 2944.0 2959.9 2971.5 2971.9 2976.4 5489.9 5698.5 5723.8 5730.2 5741.4 5667.6 5670.4 5710.5 5719.2 5769.1 5693.5 5711.2 5711.8 5734.1 5737.5 5433.7 5463.4 5541.4 5548.3 5638.4 5513.6 5543.3 5588.6 5596.5 5620.7 5492.1 5721.9 5765.5 5798.6 5800.2 3989.0 4024.7 4027.4 4043.5 4047.3 5615.0 5621.4 5626.8 5643.7 5650.0 5386.6 5491.8 5523.8 5532.4 5533.9 5412.3 5416.6 5436.4 5471.9 5474.7 5411.9 5414.7 5416.4 5441.8 5537.9 5450.5 5618.9 5709.6 5709.8 5711.0 5484.1 5575.8 5577.8 5578.2 5596.4 02:58:07 INFO - PROCESS | 11308 | 02:58:07 INFO - PROCESS | 11308 | [#5] yui.html Cycles:180 Average:17688.15 Median:25071.39 stddev:24239.43 (96.7%) stddev-sans-first:24274.09 02:58:07 INFO - PROCESS | 11308 | Values: 757.8 764.4 767.1 785.1 787.0 12540.7 12930.1 12937.2 12948.6 12949.5 13474.7 13693.9 13697.5 13703.6 13723.0 708.8 727.7 813.2 835.0 840.0 845.9 846.8 853.1 853.6 853.9 897.1 898.5 899.0 899.2 899.4 732.8 881.4 893.6 893.7 893.9 560.3 621.6 633.0 638.8 640.7 12675.9 12683.6 12708.7 12718.6 12725.7 12817.5 12926.2 13368.7 13459.7 13588.4 10886.7 10931.9 11123.2 11348.8 11382.3 4191.2 4199.3 4224.3 4239.0 4254.5 63897.7 65547.7 65576.0 65611.7 65848.3 10245.9 10441.9 10486.7 10706.3 10911.2 17762.4 17765.6 17768.9 17802.5 17836.6 7601.9 7632.4 7640.1 7666.3 8187.4 4341.0 4343.5 4387.2 4444.3 4489.8 3319.1 3416.4 3429.7 3444.7 3491.8 588.7 594.3 595.9 602.2 618.8 582.8 600.4 649.9 681.4 681.5 8468.3 8629.8 8631.4 8951.2 9037.0 597.9 659.4 690.9 712.8 726.1 4115.3 4233.9 4283.6 4295.3 4382.5 87224.6 91483.0 92488.0 92911.0 94371.5 51347.5 64558.0 80546.6 80976.0 81897.0 73036.6 73661.0 74678.3 75180.0 75666.6 8223.6 8340.5 8359.3 8629.4 8660.6 44819.9 45653.0 46157.5 46648.3 47092.8 62485.4 63796.7 63835.7 65314.3 65491.3 10910.6 11035.2 11207.3 11595.1 12148.9 12699.7 13258.6 13363.6 13398.7 13431.8 10641.9 12619.5 12711.1 13125.9 13278.6 11298.4 11455.0 11667.1 11930.5 12285.4 12829.0 12901.9 13019.5 13134.7 13665.4 10179.2 10459.3 10614.6 10811.9 10897.6 10286.7 10567.6 10912.1 11082.9 11275.0 02:58:07 INFO - PROCESS | 11308 | -------- Summary: end -------- 02:58:07 INFO - PROCESS | 11308 | 02:58:08 INFO - TEST-INFO | 11308: exit 0 02:58:08 INFO - TEST-OK | dromaeo_css | took 1115367ms 02:58:08 INFO - TEST-START | kraken 02:58:08 INFO - operating with platform_type : linux_ 02:58:08 INFO - Initialising browser for kraken test... 02:58:08 INFO - TEST-INFO | started process 11629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAe0lx/profile http://localhost:42167/getInfo.html) 02:58:12 INFO - PROCESS | 11629 | __metrics Screen width/height:1600/1200 02:58:12 INFO - PROCESS | 11629 | colorDepth:24 02:58:12 INFO - PROCESS | 11629 | Browser inner width/height: 1024/697 02:58:12 INFO - PROCESS | 11629 | __metrics 02:58:12 INFO - PROCESS | 11629 | 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" 02:58:12 INFO - PROCESS | 11629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:13 INFO - PROCESS | 11629 | console.error: PushService: 02:58:13 INFO - PROCESS | 11629 | stateChangeProcessEnqueue: Error transitioning state 02:58:13 INFO - PROCESS | 11629 | UnknownError 02:58:13 INFO - TEST-INFO | 11629: exit 0 02:58:13 INFO - Browser initialized. 02:58:13 INFO - Running cycle 1/1 for kraken test... 02:58:13 INFO - TEST-INFO | started process 11721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAe0lx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:25 INFO - PROCESS | 11721 | RSS: Main: 144261120 02:58:25 INFO - PROCESS | 11721 | 02:58:28 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:29 INFO - PROCESS | 11721 | RSS: Main: 185470976 02:58:29 INFO - PROCESS | 11721 | 02:58:31 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-dft) 02:58:32 INFO - PROCESS | 11721 | RSS: Main: 174850048 02:58:32 INFO - PROCESS | 11721 | 02:58:34 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-fft) 02:58:35 INFO - PROCESS | 11721 | RSS: Main: 266117120 02:58:35 INFO - PROCESS | 11721 | 02:58:37 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42167/tests/kraken/driver.html?testName=audio-oscillator) 02:58:38 INFO - PROCESS | 11721 | RSS: Main: 172638208 02:58:38 INFO - PROCESS | 11721 | 02:58:40 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:40 INFO - PROCESS | 11721 | RSS: Main: 175681536 02:58:40 INFO - PROCESS | 11721 | 02:58:43 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:44 INFO - PROCESS | 11721 | RSS: Main: 213794816 02:58:44 INFO - PROCESS | 11721 | 02:58:47 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42167/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:48 INFO - PROCESS | 11721 | RSS: Main: 212983808 02:58:48 INFO - PROCESS | 11721 | 02:58:51 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42167/tests/kraken/driver.html?testName=json-parse-financial) 02:58:51 INFO - PROCESS | 11721 | RSS: Main: 211701760 02:58:51 INFO - PROCESS | 11721 | 02:58:53 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42167/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:53 INFO - PROCESS | 11721 | RSS: Main: 173547520 02:58:53 INFO - PROCESS | 11721 | 02:58:55 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:56 INFO - PROCESS | 11721 | RSS: Main: 180150272 02:58:56 INFO - PROCESS | 11721 | 02:58:58 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:58 INFO - PROCESS | 11721 | RSS: Main: 189607936 02:58:58 INFO - PROCESS | 11721 | 02:59:01 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:01 INFO - PROCESS | 11721 | RSS: Main: 197890048 02:59:01 INFO - PROCESS | 11721 | 02:59:04 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:05 INFO - PROCESS | 11721 | RSS: Main: 194646016 02:59:05 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | Cycle 1(1): loaded http://localhost:42167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42167/tests/kraken/driver.html?testName=ai-astar) 02:59:06 INFO - PROCESS | 11721 | RSS: Main: 246366208 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | __start_tp_report 02:59:06 INFO - PROCESS | 11721 | _x_x_mozilla_page_load 02:59:06 INFO - PROCESS | 11721 | _x_x_mozilla_page_load_details 02:59:06 INFO - PROCESS | 11721 | |i|pagename|runs| 02:59:06 INFO - PROCESS | 11721 | |0;ai-astar;102;112;112;112;111;110;111;110;111;111 02:59:06 INFO - PROCESS | 11721 | |1;audio-beat-detection;160;120;121;166;121;120;118;120;150;120 02:59:06 INFO - PROCESS | 11721 | |2;audio-dft;161;162;162;160;160;161;160;161;159;161 02:59:06 INFO - PROCESS | 11721 | |3;audio-fft;75;75;74;108;76;76;76;75;101;74 02:59:06 INFO - PROCESS | 11721 | |4;audio-oscillator;82;82;112;83;83;81;100;82;82;106 02:59:06 INFO - PROCESS | 11721 | |5;imaging-gaussian-blur;117;117;116;117;116;118;117;117;117;117 02:59:06 INFO - PROCESS | 11721 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;147;147 02:59:06 INFO - PROCESS | 11721 | |7;imaging-desaturate;85;85;85;84;85;85;88;86;85;86 02:59:06 INFO - PROCESS | 11721 | |8;json-parse-financial;52;51;51;51;51;50;51;57;54;53 02:59:06 INFO - PROCESS | 11721 | |9;json-stringify-tinderbox;59;59;58;59;60;59;59;59;59;59 02:59:06 INFO - PROCESS | 11721 | |10;stanford-crypto-aes;75;74;75;74;75;74;74;76;82;78 02:59:06 INFO - PROCESS | 11721 | |11;stanford-crypto-ccm;131;120;121;121;119;119;119;118;158;130 02:59:06 INFO - PROCESS | 11721 | |12;stanford-crypto-pbkdf2;158;155;157;158;158;160;157;153;163;157 02:59:06 INFO - PROCESS | 11721 | |13;stanford-crypto-sha256-iterative;62;63;65;63;63;64;65;61;64;63 02:59:06 INFO - PROCESS | 11721 | __end_tp_report 02:59:06 INFO - PROCESS | 11721 | __start_cc_report 02:59:06 INFO - PROCESS | 11721 | _x_x_mozilla_cycle_collect,1593 02:59:06 INFO - PROCESS | 11721 | __end_cc_report 02:59:06 INFO - PROCESS | 11721 | __startTimestamp1481713146979__endTimestamp 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | ------- Summary: start ------- 02:59:06 INFO - PROCESS | 11721 | Number of tests: 14 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.97 (2.7%) stddev-sans-first:0.78 02:59:06 INFO - PROCESS | 11721 | Values: 102.0 112.0 112.0 112.0 111.0 110.0 111.0 110.0 111.0 111.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:121.00 stddev:19.08 (15.8%) stddev-sans-first:17.25 02:59:06 INFO - PROCESS | 11721 | Values: 160.0 120.0 121.0 166.0 121.0 120.0 118.0 120.0 150.0 120.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:59:06 INFO - PROCESS | 11721 | Values: 161.0 162.0 162.0 160.0 160.0 161.0 160.0 161.0 159.0 161.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:12.52 (16.7%) stddev-sans-first:13.09 02:59:06 INFO - PROCESS | 11721 | Values: 75.0 75.0 74.0 108.0 76.0 76.0 76.0 75.0 101.0 74.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:11.88 (14.5%) stddev-sans-first:12.30 02:59:06 INFO - PROCESS | 11721 | Values: 82.0 82.0 112.0 83.0 83.0 81.0 100.0 82.0 82.0 106.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:59:06 INFO - PROCESS | 11721 | Values: 117.0 117.0 116.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:59:06 INFO - PROCESS | 11721 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 02:59:06 INFO - PROCESS | 11721 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 88.0 86.0 85.0 86.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.50 stddev:2.08 (4.0%) stddev-sans-first:2.20 02:59:06 INFO - PROCESS | 11721 | Values: 52.0 51.0 51.0 51.0 51.0 50.0 51.0 57.0 54.0 53.0 02:59:06 INFO - PROCESS | 11721 | 02:59:06 INFO - PROCESS | 11721 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 02:59:06 INFO - PROCESS | 11721 | Values: 59.0 59.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 02:59:06 INFO - PROCESS | 11721 | 02:59:07 INFO - PROCESS | 11721 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:2.54 (3.4%) stddev-sans-first:2.68 02:59:07 INFO - PROCESS | 11721 | Values: 75.0 74.0 75.0 74.0 75.0 74.0 74.0 76.0 82.0 78.0 02:59:07 INFO - PROCESS | 11721 | 02:59:07 INFO - PROCESS | 11721 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:121.00 stddev:12.29 (10.2%) stddev-sans-first:12.88 02:59:07 INFO - PROCESS | 11721 | Values: 131.0 120.0 121.0 121.0 119.0 119.0 119.0 118.0 158.0 130.0 02:59:07 INFO - PROCESS | 11721 | 02:59:07 INFO - PROCESS | 11721 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:2.67 (1.7%) stddev-sans-first:2.83 02:59:07 INFO - PROCESS | 11721 | Values: 158.0 155.0 157.0 158.0 158.0 160.0 157.0 153.0 163.0 157.0 02:59:07 INFO - PROCESS | 11721 | 02:59:07 INFO - PROCESS | 11721 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.24 02:59:07 INFO - PROCESS | 11721 | Values: 62.0 63.0 65.0 63.0 63.0 64.0 65.0 61.0 64.0 63.0 02:59:07 INFO - PROCESS | 11721 | -------- Summary: end -------- 02:59:07 INFO - PROCESS | 11721 | 02:59:08 INFO - TEST-INFO | 11721: exit 0 02:59:08 INFO - TEST-OK | kraken | took 59541ms 02:59:08 INFO - SUITE-END | took 1174s 02:59:08 INFO - Completed test suite (00:19:34) 02:59:08 INFO - javascript benchmark 02:59:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.5696780934572, 3209.903702888913, 3228.1122691259916, 3250.431174544457, 3270.9182270443252, 5572.60991730579, 5665.150227465882, 5676.574256930737, 5690.544756419492, 5703.572232082595, 5621.831345059644, 5681.177357134655, 5697.658140511572, 5703.800366987156, 5722.113072473763, 5097.898042039166, 5129.179331306992, 5146.716930568836, 5158.252053452247, 5194.506521880416, 5009.599232061426, 5009.699418034911, 5104.132297509414, 5245.816396426126, 5268.446813084628, 5103.668261563005, 5234.6335756497065, 5246.1606143017125, 5247.396549396811, 5249.1338929076655, 5242.9213561796605, 5248.711320877369, 5253.921191182136, 5260.894782104375, 5293.23248129023, 4863.1732605457155, 4954.43024052235, 5153.0, 5162.819301324435, 5219.765110570033, 5529.723513824333, 5567.805126820583, 5568.49883510482, 5611.0, 5626.409227031144, 5989.161517387569, 5995.130706047598, 6034.939650603482, 6089.725962331661, 6097.756089756404, 5735.684537350444, 6101.969490152565, 6110.114033465167, 6118.877622447526, 6121.265448146207, 5394.811181608625, 5557.472040156179, 5607.803726869581, 5637.7181140942785, 5706.0, 6112.877742445126, 6134.38656134383, 6135.294441139237, 6138.048602466535, 6145.324014358417, 5748.511376532958, 5940.6435613863305, 5944.64332140073, 5949.1076338549565, 5954.374790647006, 5877.294724633071, 5963.403659634002, 6024.0, 6028.09578563219, 6130.29501607312, 5989.221401217814, 6030.517558595389, 6044.879102417927, 6054.212952316258, 6056.454919057306, 6060.151578778975, 6061.424164704346, 6062.969685151546, 6073.210482637229, 6087.9391206087375, 4468.597826195658, 4496.572825581565, 4616.492185859553, 4646.09401166776, 4649.86050418488, 4143.02638879863, 4158.604932531404, 4169.45797046382, 4188.308929026737, 4193.895152621148, 5712.285964254468, 5715.742791574389, 5716.485516303553, 5719.828405147852, 5721.313442386941, 5826.41735826414, 5877.52979761618, 5906.3207731110615, 5924.0, 6115.388461153849, 5613.382527921925, 5620.522255608319, 5624.803131890364, 5635.295588051494, 5656.717164141776, 5138.023775482647, 5139.254808052886, 5140.049090918192, 5147.6654017488745, 5174.767135478913, 5894.263217097863, 6016.488598469179, 6047.879042419215, 6101.694915254308, 6111.694415279218, 5943.227380440515, 6019.036954087325, 6022.337542870193, 6045.727942242522, 6051.4553690168095, 6150.261968563801, 6177.938220617736, 6185.721642526007, 6189.473894718819, 6191.84520386994, 5667.036603777286, 5674.631148975303, 5936.37668044849, 5942.405759424023, 5945.10823376497, 6034.577579569388, 6071.332153463204, 6074.0281554951, 6141.1310874149, 6145.279321789906, 5946.851328716817, 5997.340292567901, 5997.760089596542, 6004.279486461653, 6026.638401695912, 5635.492805647511, 5974.044152935509, 5980.5215582754145, 5984.431479009487, 5985.880282394241, 5695.544356451557, 5706.9714651426475, 5748.223989761496, 5748.856278592902, 5847.912281315868, 5886.676232807065, 5910.202122713378, 5912.556558258234, 5914.526837853047, 5915.970420147872, 5521.806736764194, 5552.972235138798, 5563.02647036775, 5762.1644861494015, 5762.798302059407], "value": 5543.263300958494, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8086450606794, 582.1384351160283, 599.8620317327014, 602.3524710935742, 605.657803341112, 33381.66618333816, 44792.552074479245, 46372.0, 46569.0, 49331.0, 47684.28473572891, 48264.0, 48349.274760878616, 48411.75794121033, 48412.51587484124, 8272.090070092285, 8850.73447796567, 8993.190612844875, 8993.28053755698, 9009.819803603925, 8230.42387032908, 8544.914550854504, 8547.572621368938, 10543.31468454548, 10847.349159050444, 10908.672739817817, 10961.397123158264, 10962.068224200952, 10969.670909872677, 10974.615888443906, 10656.0, 10664.0, 10687.732806679818, 10702.732431689192, 10718.999999999962, 10706.946465267623, 10775.0, 10788.244822862403, 10791.892081079168, 10799.2440529163, 44585.0, 44776.3283550747, 44959.550404495865, 44964.77517612391, 44965.0, 3674.879161855633, 3781.810909454516, 3880.1657643606477, 3912.4131380292897, 4207.474065741782, 33951.15122121967, 33971.0, 34116.48825267623, 34191.145221369414, 34236.657633423594, 4532.0, 4594.081183763261, 4620.237660785966, 4723.291506274052, 4724.267738500538, 359245.0, 360357.0, 361736.0, 362072.0, 363173.0, 65141.348586514476, 65333.0, 65356.346436535976, 65426.345736542025, 65440.67279663667, 40327.0, 41194.38208426876, 41470.1705965879, 69748.30251697417, 69841.65079174572, 15970.60073498172, 16216.270267837976, 16234.75647865283, 16244.431444899608, 16265.51203463898, 10732.356058636507, 12951.0, 13082.934585327203, 13105.475780968654, 13183.077184596987, 18259.72610410845, 19556.132511171523, 21513.462163445725, 21514.247001354877, 21531.569368612854, 7195.820104497429, 7235.2764723527225, 7301.0, 7424.290134101014, 7455.85088298231, 996.2080146283722, 1070.8233141531716, 1094.9014588687057, 1154.4112502623723, 1190.3691043746828, 34307.313853722786, 34894.476582851275, 35112.54530899612, 35150.824245878604, 35259.294814103574, 1151.3840095548842, 1228.5638598297655, 1243.1795015290047, 1245.5578269714122, 1258.2324781883044, 17241.793074484918, 17966.820331796775, 17973.460796176136, 18015.099245037694, 18029.0, 540908.0, 616165.0, 625227.0, 625684.0, 918460.0, 62750.686246568475, 63514.36485635177, 63616.0, 63726.36273637297, 63806.6809665958, 1248.950041998328, 1333.7399207154706, 1389.208151353739, 1431.2628996067033, 1459.7080583883053, 31144.53283200799, 34829.30341393209, 37430.251394972496, 37448.0, 37489.812550938164, 59808.401915982024, 60768.78462430815, 60794.08808867782, 60808.695956519936, 60826.695866520386, 511432.0, 515851.0, 516135.0, 516710.0, 518002.0, 28262.85868570644, 29198.854005729834, 29459.705402945696, 30930.226744331572, 32145.196370090936, 48997.0, 49806.75096624494, 50584.747076264386, 50594.0, 51530.0, 42614.57385426106, 43659.781701092565, 44011.77994110009, 44391.33412998743, 44869.55130448654, 43537.0, 44416.0, 44733.105337893714, 44871.0, 45364.54635453735, 39049.804750976065, 39656.0, 43270.0, 44388.33417498805, 44563.0, 36964.815175925025, 39601.207975840895, 40028.39957400583, 40217.79891100526, 40474.797626011685, 29578.556321654763, 29689.406211876074, 29967.850160749058, 30202.0, 30240.185588864737], "value": 21600.879504008873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.08197171152733, 427.3354933079062, 429.3208836694422, 435.45568039950064, 441.97348159110453, 18423.263069477223, 18918.90540547297, 20294.0, 20321.390358289256, 20463.079161437734, 18877.71683424746, 19063.142158602863, 19268.3256086037, 19282.51793705158, 19429.708554371697, 5568.554515638739, 5815.273090863642, 5824.825255242328, 5825.796097136601, 5832.825015249549, 5528.723563821813, 5629.380768115504, 5709.600327977043, 5711.171880077386, 5757.539396848242, 5756.02147634903, 5757.99235133852, 5759.798407055754, 5764.308283006024, 5765.1928729977835, 5547.195656629786, 5633.6619802811965, 5688.658680479184, 5757.078867381219, 5760.164776107462, 5080.568151707109, 5083.339165908408, 5084.0, 5087.720175390352, 5089.898202035975, 22792.202272920367, 23131.421714457105, 23142.7685723144, 23168.420789480228, 23314.06743730249, 2131.1262382423133, 2271.4775601611723, 2394.078279862248, 2408.6146216605257, 2654.9469010619873, 14161.504347347896, 14515.564533064025, 14643.780343294859, 14698.632534186623, 15173.924130379277, 1868.4021113243768, 2032.7662318833375, 2045.1001559313854, 2097.5070858348276, 2125.1286972341422, 55528.26776791976, 60632.39367606312, 76596.0, 82099.0, 85054.14945850585, 10185.796284074277, 10361.74095647615, 10518.263721539419, 10786.568537258421, 11356.318620882608, 16034.839651603568, 16045.277962491717, 16062.116583587782, 16062.43781467643, 16087.276072576762, 7929.0, 8101.675932962733, 8146.9592652037545, 8163.510189388656, 8342.749717508485, 7616.314531692175, 7661.61691915402, 7682.692692292358, 7918.326942209977, 7922.0, 6695.46436285096, 6802.14973128359, 6829.897551536731, 6883.552569083094, 7003.859922801617, 1969.4780883065998, 2045.818751840872, 2063.515073957619, 2072.171131547363, 2139.5720855828895, 814.4380377539479, 930.2650905784354, 1074.258761454594, 1076.4617691154422, 1136.1649187846926, 19381.90309048446, 19409.51476213106, 19544.51138721515, 19626.607467850565, 19828.405147845588, 1031.9587216511406, 1039.2257767962765, 1053.3995622495258, 1060.7136073260176, 1064.41989115932, 10630.415327156927, 11524.135689823297, 11563.595274165364, 11642.185047046625, 11666.300021998708, 494119.0, 496194.0, 506802.0, 507971.0, 511493.0, 84017.0, 86893.56553217194, 87130.0, 88523.0, 88786.0, 1049.3074570783247, 1050.4852622215212, 1051.9789604207872, 1054.7732237568805, 1081.1783044885785, 17388.043657598446, 17440.127993600014, 18010.279588816302, 18030.1886415109, 18260.817391825913, 41836.79081604572, 41917.79041104775, 42010.579894200666, 42540.57459425366, 43505.34741978936, 54546.18180727213, 55088.44911550833, 55586.44413555813, 55894.0, 57156.142192889354, 8398.538080405637, 8475.788105297417, 8769.38614296993, 8994.595243214202, 9071.909280907106, 12309.384530773605, 12546.184498007966, 12879.356032198166, 13057.673558161123, 13396.732065358443, 6972.884338505814, 9941.105300522988, 11556.364399958084, 11587.130965177477, 11767.88232117668, 5457.399686034612, 8688.478691278544, 11031.455596216696, 11072.667819965414, 11174.0, 11253.831192531954, 11269.774604508028, 11343.262687925258, 11490.253133546294, 12064.577739779066, 7445.553266804009, 8132.227438393344, 8150.510969341858, 8420.957895210484, 8846.513441760764, 9364.391314564531, 11982.281063136239, 12082.818757718465, 12142.39288035577, 12359.25844449336], "value": 9346.84144741734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.733871572475, 1539.753639417693, 1678.16091954023, 1785.348347853034, 1833.8807977481463, 8637.352198585108, 9164.175224229817, 9166.495842728647, 9176.17414432701, 9191.310651701124, 7875.409344299186, 8119.837603247932, 8527.445716028455, 8760.211580957712, 8959.776005599862, 2516.232549072532, 2550.1839411388364, 2555.974440255592, 2557.3734435063434, 2558.577834657289, 2366.1008816649737, 2418.0811291709124, 2438.0491608272787, 2442.9389265268333, 2444.10790061628, 2508.046942161976, 2511.1211076123395, 2516.8112391570708, 2519.6472493850874, 2527.772500474957, 2435.464197876473, 2463.2117722328862, 2484.1181380609983, 2487.2911220302217, 2491.202815099169, 2486.813488988333, 2493.650888875559, 2515.748425157488, 2517.093846215361, 2518.987405062963, 8979.281657467453, 9009.144131307516, 9092.136247056518, 9092.590833412512, 9106.544672766335, 5599.860003499945, 5734.684592347419, 5736.2256095427, 5743.655380677131, 5744.798932037401, 3609.097725568608, 3659.505966694489, 3681.7975011374365, 3759.9436008459893, 3848.5958974307855, 1257.076049103908, 1266.1263728027723, 1279.1174089878048, 1297.4161627267767, 1325.9270740109291, 12810.29543375114, 12860.549880754128, 12885.549005784753, 12902.54841080567, 12987.025973051965, 4975.328330675313, 5095.471358592482, 5274.446183150791, 5276.947230527646, 5294.682319060868, 10825.188110891715, 10845.07816835562, 10846.240763146505, 10849.78300433987, 10860.076893463985, 5789.247397838339, 5791.797287095016, 5794.333651630032, 5794.362620111784, 5795.304563452412, 4359.629431498358, 5092.516210959953, 5147.845564633067, 5210.244514545446, 5239.816606418757, 4145.398917156996, 4185.602367775056, 4211.684123690736, 4241.427407300037, 4247.893802654959, 1357.362039841273, 1406.4444544405108, 1408.1621435246013, 1416.044170185121, 1420.2472689474596, 982.1160955140431, 998.8152191844532, 1005.1550235381235, 1005.9647912323034, 1014.6702321745462, 5789.797357092481, 5975.492083172892, 6012.879742405127, 6060.484858787053, 6260.436560709558, 478.4234996828813, 489.81387072912065, 490.17650347416685, 491.59197865771324, 497.41553674432396, 4031.576684448091, 4151.4395556600075, 4159.209750147463, 4203.201391735561, 4276.72201306914, 10984.505697243643, 11392.886071139183, 11455.198136130392, 11511.654650360502, 11536.365499897585, 11268.323900565993, 11314.151438642135, 11353.0, 11396.430178491042, 11408.144389170846, 8083.878741818878, 8387.706430274911, 8433.451825631315, 8458.407911446262, 8528.147185281547, 6116.217121209927, 6329.430351268408, 6342.651154186564, 6357.364263573606, 6360.618362898241, 10260.743481413025, 10292.845607315747, 10412.583496660049, 10417.635382761568, 10462.424566648602, 10240.948795255976, 10343.741406464898, 10432.947835261079, 10554.894451055698, 10633.0, 7304.306090921354, 7576.4317676173405, 7862.2923936845955, 8185.4270201085355, 8334.20825021622, 8882.15619516145, 8947.507887066275, 8955.731328060168, 8961.193492585699, 8962.73111806647, 7652.961735191511, 7859.685612575661, 7886.329661978796, 7893.684252629831, 7919.16848730875, 7735.9226407735205, 7837.41219408558, 7853.882191767242, 7860.331871790733, 8062.516249025077, 7126.429885609243, 7205.027321311556, 7213.134423869169, 7227.385672217921, 7323.780286591411, 5335.546478549367, 5356.303680521507, 5439.347278326626, 5509.779608815763, 5536.169574563848, 5535.640183388067, 5540.722963851711, 5601.075822489406, 5638.097904335286, 5724.484796368347], "value": 4796.9035343703445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2907610322735, 354.97870127792334, 358.6628569145002, 359.148817302992, 362.44183956706667, 5438.700871452069, 5455.699936503491, 5519.448055194479, 5529.308836395446, 5584.134459158832, 5162.6644268122545, 5198.636095473309, 5257.739172155972, 5262.9473705262935, 5462.426445223244, 4246.171996460692, 4257.233697934378, 4262.360645903108, 4268.0, 4285.571442855705, 4279.2083464559155, 4316.352547117926, 4335.978320108395, 4339.9819084125875, 4365.759883206422, 3971.8808435746973, 4005.5794141615147, 4275.05948691289, 4275.700700950934, 4289.678274129437, 4264.87205383839, 4265.936010959838, 4274.615284624383, 4277.593628605277, 4282.935755963647, 3853.0560012797046, 3854.8843534693724, 3864.9613503864884, 3871.4386413970096, 3876.8449262029485, 5105.361829771278, 5187.533122018998, 5231.267622532849, 5237.16205407133, 5244.344456942882, 4924.630652701026, 4929.0, 4932.358793356877, 4936.876578085541, 4939.259111133323, 5620.297462817148, 5640.09758438652, 5647.915281270784, 5652.689102099383, 5675.871548169436, 4141.213169497786, 4227.598378154071, 4240.300350442204, 4248.87253382399, 4257.659387249013, 5766.913496297559, 5778.930897783924, 5807.2160258365, 5813.302403711539, 5837.50381217597, 4321.308590625485, 4324.978375108104, 4326.394304797331, 4340.305551111807, 4351.43431353922, 4009.4186342980106, 4187.371894215892, 4212.768297743653, 4415.315626077963, 4419.580139886705, 4753.47711751707, 4754.23932170851, 4758.476567577563, 4779.545943135397, 4795.544423279783, 5591.329040515164, 5624.578156638268, 5644.322681278273, 5649.350324712628, 5652.660840349592, 1382.4401117547409, 1427.978580321296, 1430.5708287513705, 1438.7266419380285, 1444.2850788859582, 930.3952430919957, 953.9379940303996, 981.8821741390936, 991.1525645573075, 1006.8993100690019, 5152.92270615941, 5165.819196328111, 5167.896642067213, 5233.398159211663, 5237.831112177078, 5532.478568393643, 5566.165075238747, 5568.805091821767, 5575.972120139373, 5583.274174357308, 5185.522126194017, 5186.948130518722, 5420.728963551806, 5444.455554444524, 5472.179173123984, 2944.0284706046955, 2959.926001849971, 2971.539411391238, 2971.9108426747234, 2976.4493568689427, 5489.862753431196, 5698.515626171739, 5723.828285151452, 5730.226419433407, 5741.368449470555, 5667.574931880043, 5670.432956704297, 5710.457506536873, 5719.227904232958, 5769.134629805562, 5693.459121383462, 5711.171880077449, 5711.771529138788, 5734.111212761945, 5737.483626473638, 5433.701146436984, 5463.371712253142, 5541.3904470509015, 5548.334199896039, 5638.436156384493, 5513.641613295123, 5543.341394679493, 5588.552915766811, 5596.516923015485, 5620.74706638194, 5492.148716948879, 5721.882903325796, 5765.538756899354, 5798.594098413239, 5800.24596802413, 3988.980055099706, 4024.665693897591, 4027.4361589376927, 4043.534993475788, 4047.332190188586, 5614.9719251403485, 5621.381648018796, 5626.774929002958, 5643.746031428514, 5649.971750141387, 5386.649867758583, 5491.780328786964, 5523.784767351176, 5532.419095994863, 5533.861653458695, 5412.319622656474, 5416.620836541404, 5436.40199578054, 5471.863203419946, 5474.671519708831, 5411.945880541144, 5414.7021913795115, 5416.431274716256, 5441.809536666197, 5537.916931246115, 5450.5367043801725, 5618.943810561842, 5709.571782116275, 5709.771609135588, 5711.0, 5484.149956756709, 5575.77696892136, 5577.804776832953, 5578.163275508706, 5596.356419011866], "value": 4282.69251620054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.821911850715, 764.4419573711187, 767.0948281028387, 785.065771731639, 786.9921300786992, 12540.749185016295, 12930.094893357456, 12937.223766574012, 12948.611541653765, 12949.546765863197, 13474.730505389887, 13693.93153034236, 13697.520586779465, 13703.58889233322, 13723.0, 708.7802781137838, 727.6834576959039, 813.1786895235825, 834.9624266908004, 840.0255703384075, 845.9069502354766, 846.8094678697305, 853.1085016158098, 853.63293783673, 853.9231469167773, 897.107378158733, 898.5103118800237, 899.0245583541865, 899.2086963472135, 899.3749344205779, 732.8167958010497, 881.3830318776818, 893.5621545442718, 893.7184786792172, 893.9106089391074, 560.2548610348268, 621.6456619726757, 632.9936700633027, 638.7572722365518, 640.679660169915, 12675.873241267562, 12683.556075537404, 12708.745825083539, 12718.618441446772, 12725.681857953532, 12817.487300507968, 12926.159799612995, 13368.732625347537, 13459.730805383935, 13588.405566837351, 10886.72783180419, 10931.945340273327, 11123.16576256784, 11348.829767553494, 11382.260153090023, 4191.2395653014955, 4199.307114326132, 4224.345226489899, 4238.978805105986, 4254.468191476066, 63897.680511597144, 65547.67226163886, 65576.0, 65611.67194164047, 65848.34151658518, 10245.948770256102, 10441.895581044093, 10486.737831554272, 10706.304090234109, 10911.23621346514, 17762.37831675885, 17765.644687106185, 17768.91115544414, 17802.46592602224, 17836.55408614769, 7601.923980760122, 7632.389408847279, 7640.083190017233, 7666.271704188205, 8187.38594605407, 4340.978295108567, 4343.500497442771, 4387.232234358974, 4444.28891377378, 4489.775511224426, 3319.1204330852343, 3416.3850506908498, 3429.7427692922633, 3444.689977901951, 3491.7730347527836, 588.6909372579345, 594.3343455329972, 595.9165716799652, 602.193061297863, 618.7896115320813, 582.8249694486905, 600.4355905448864, 649.9252585952581, 681.3969636871306, 681.5331497923938, 8468.32253419725, 8629.827403452022, 8631.438956467935, 8951.194392504705, 9037.0, 597.8624916269282, 659.4295934017041, 690.8860038093658, 712.8004158835535, 726.1286456252412, 4115.303723864901, 4233.8518151865155, 4283.571642835754, 4295.334223195409, 4382.474103107584, 87224.5638771802, 91483.0, 92488.0, 92911.0, 94371.52814235885, 51347.48652513502, 64558.0, 80546.59726701329, 80976.0, 81897.0, 73036.63481682558, 73661.0, 74678.25321746821, 75179.99280028738, 75666.62166689131, 8223.588820558829, 8340.541270230196, 8359.289460395934, 8629.43908645936, 8660.62235728054, 44819.879503012686, 45653.0, 46157.538424615326, 46648.30027549657, 47092.76453617847, 62485.375146247956, 63796.68101659462, 63835.6808215956, 65314.34685653083, 65491.34508654852, 10910.563577456813, 11035.227534072537, 11207.271527350696, 11595.13036522281, 12148.939255303667, 12699.682507937376, 13258.602241932758, 13363.599092027254, 13398.732025359242, 13431.798523022358, 10641.946790266, 12619.49522019109, 12711.110222284722, 13125.868741312846, 13278.601641950758, 11298.43507824589, 11455.0, 11667.124965627441, 11930.463129159036, 12285.385730713608, 12829.0, 12901.870981290067, 13019.544315948897, 13134.671633209246, 13665.437205389657, 10179.185665146622, 10459.267851250339, 10614.628488002883, 10811.891881081403, 10897.564097436014, 10286.691399258034, 10567.63013294531, 10912.127029837753, 11082.889171108185, 11275.0], "value": 6939.348682251371, "unit": "score"}], "name": "dromaeo_css", "value": 7364.738604371749, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 112.0, 111.0, 110.0, 111.0, 110.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 121.0, 166.0, 121.0, 120.0, 118.0, 120.0, 150.0, 120.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 108.0, 76.0, 76.0, 76.0, 75.0, 101.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 83.0, 81.0, 100.0, 82.0, 82.0, 106.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 88.0, 86.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 50.0, 51.0, 57.0, 54.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 74.0, 75.0, 74.0, 74.0, 76.0, 82.0, 78.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 121.0, 121.0, 119.0, 119.0, 119.0, 118.0, 158.0, 130.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 157.0, 158.0, 158.0, 160.0, 157.0, 153.0, 163.0, 157.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 63.0, 63.0, 64.0, 65.0, 61.0, 64.0, 63.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1454.6999999999998, "alertThreshold": 2.0}]} 02:59:08 INFO - Return code: 0 02:59:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:08 INFO - # TBPL SUCCESS # 02:59:08 INFO - Running post-action listener: _resource_record_post_action 02:59:08 INFO - [mozharness: 2016-12-14 10:59:08.267757Z] Finished run-tests step (success) 02:59:08 INFO - Running post-run listener: _resource_record_post_run 02:59:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 353660928; Read time: 20; Write time: 224188 02:59:08 INFO - TinderboxPrint: CPU usage
13.0% 02:59:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 02:59:08 INFO - TinderboxPrint: I/O write bytes / time
353,660,928 / 224,188 02:59:08 INFO - TinderboxPrint: CPU idle
8,269.4 (87.0%) 02:59:08 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 02:59:08 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107630592; Read time: 0; Write time: 98280 02:59:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 245415936; Read time: 0; Write time: 125908 02:59:08 INFO - Running post-run listener: _upload_blobber_files 02:59:08 INFO - Blob upload gear active. 02:59:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:08 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 02:59:08 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'] 02:59:08 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 02:59:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:59:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:10 INFO - (blobuploader) - INFO - Done attempting. 02:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:10 INFO - (blobuploader) - INFO - Done attempting. 02:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:14 INFO - (blobuploader) - INFO - Done attempting. 02:59:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:14 INFO - Return code: 0 02:59:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f5da82cb46c6198c8a09a3733d9e240ab1d6d8b2d6f8a7b94fba9ae5db466090e92a94e81fdfda439079e3c59201b65c2ce51b4a7363b0dbfb9e1dee99250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239163a8a04b6cc48ab190d7b49335e725945ec814ff48b7fa48cfb61b1772e31cb99090c39dd14e34e0115d4df7dea34676a8293e3fb2a432a4880d6470dad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d99d6d1d164c888cc3c1bdc28f3521d72c1c368f578e82fa57c7e55f8f19ffae087864e7aee8b78c994623a06c170de1b10ff5ba7e09ab5f648ca018cc7f663b"} 02:59:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:14 INFO - Contents: 02:59:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c16f5da82cb46c6198c8a09a3733d9e240ab1d6d8b2d6f8a7b94fba9ae5db466090e92a94e81fdfda439079e3c59201b65c2ce51b4a7363b0dbfb9e1dee99250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239163a8a04b6cc48ab190d7b49335e725945ec814ff48b7fa48cfb61b1772e31cb99090c39dd14e34e0115d4df7dea34676a8293e3fb2a432a4880d6470dad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d99d6d1d164c888cc3c1bdc28f3521d72c1c368f578e82fa57c7e55f8f19ffae087864e7aee8b78c994623a06c170de1b10ff5ba7e09ab5f648ca018cc7f663b"} 02:59:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:14 INFO - Copying logs to upload dir... 02:59:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.533921 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-14 02:59:13.581367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 02:59:13.584497) ========= 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-1481711915.68342-1868818991 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/c16f5da82cb46c6198c8a09a3733d9e240ab1d6d8b2d6f8a7b94fba9ae5db466090e92a94e81fdfda439079e3c59201b65c2ce51b4a7363b0dbfb9e1dee99250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239163a8a04b6cc48ab190d7b49335e725945ec814ff48b7fa48cfb61b1772e31cb99090c39dd14e34e0115d4df7dea34676a8293e3fb2a432a4880d6470dad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d99d6d1d164c888cc3c1bdc28f3521d72c1c368f578e82fa57c7e55f8f19ffae087864e7aee8b78c994623a06c170de1b10ff5ba7e09ab5f648ca018cc7f663b"} build_url:https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011741 build_url: 'https://queue.taskcluster.net/v1/task/cgOiLIEKRUiQjpe-BPSe1Q/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/c16f5da82cb46c6198c8a09a3733d9e240ab1d6d8b2d6f8a7b94fba9ae5db466090e92a94e81fdfda439079e3c59201b65c2ce51b4a7363b0dbfb9e1dee99250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239163a8a04b6cc48ab190d7b49335e725945ec814ff48b7fa48cfb61b1772e31cb99090c39dd14e34e0115d4df7dea34676a8293e3fb2a432a4880d6470dad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d99d6d1d164c888cc3c1bdc28f3521d72c1c368f578e82fa57c7e55f8f19ffae087864e7aee8b78c994623a06c170de1b10ff5ba7e09ab5f648ca018cc7f663b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 02:59:13.610368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:59:13.610718) ========= 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-1481711915.68342-1868818991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 02:59:13.696600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 02:59:13.696914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 02:59:13.697219) ========= ========= Total master_lag: 2.24 =========