builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1479450070.68 results: success (0) buildid: 20161117193213 builduid: 83be7b5830364cf586806b65848ad775 revision: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.675868) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.676422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.676748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.691438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.691733) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 22:21:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-11-17 22:21:11 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.861892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.862174) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015142 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:10.924369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 22:21:10.924702) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a --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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 22:21:11,332 truncating revision to first 12 chars 2016-11-17 22:21:11,332 Setting DEBUG logging. 2016-11-17 22:21:11,332 attempt 1/10 2016-11-17 22:21:11,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8e476f8bd52d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 22:21:12,254 unpacking tar archive at: mozilla-central-8e476f8bd52d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.514854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 22:21:12.452889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:12.453217) ========= script_repo_revision: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:12.453627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:12.453900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 22:21:12.463086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-17 22:21:12.463375) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:21:12 INFO - MultiFileLogger online at 20161117 22:21:12 in /builds/slave/test 22:21:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:21:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:21:12 INFO - {'append_to_log': False, 22:21:12 INFO - 'base_work_dir': '/builds/slave/test', 22:21:12 INFO - 'blob_upload_branch': 'Firefox', 22:21:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:21:12 INFO - 'branch': 'Firefox', 22:21:12 INFO - 'buildbot_json_path': 'buildprops.json', 22:21:12 INFO - 'config_files': ('talos/linux_config.py',), 22:21:12 INFO - 'default_actions': ('clobber', 22:21:12 INFO - 'read-buildbot-config', 22:21:12 INFO - 'download-and-extract', 22:21:12 INFO - 'populate-webroot', 22:21:12 INFO - 'create-virtualenv', 22:21:12 INFO - 'install', 22:21:12 INFO - 'run-tests'), 22:21:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:21:12 INFO - 'download_minidump_stackwalk': True, 22:21:12 INFO - 'download_symbols': 'ondemand', 22:21:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:21:12 INFO - 'tooltool.py': '/tools/tooltool.py', 22:21:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:21:12 INFO - '/tools/misc-python/virtualenv.py')}, 22:21:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:21:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:21:12 INFO - 'installer_path': 'installer.exe', 22:21:12 INFO - 'log_level': 'info', 22:21:12 INFO - 'log_name': 'talos', 22:21:12 INFO - 'log_to_console': True, 22:21:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:21:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:21:12 INFO - 'opt_config_files': (), 22:21:12 INFO - 'pip_index': False, 22:21:12 INFO - 'sps_profile': False, 22:21:12 INFO - 'sps_profile_interval': 0, 22:21:12 INFO - 'suite': 'dromaeojs-e10s', 22:21:12 INFO - 'system_bits': '32', 22:21:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:21:12 INFO - 'title': 'talos-linux64-ix-061', 22:21:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:21:12 INFO - 'use_talos_json': True, 22:21:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:21:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:21:12 INFO - 'work_dir': 'build'} 22:21:12 INFO - [mozharness: 2016-11-18 06:21:12.969670Z] Running clobber step. 22:21:12 INFO - Running pre-action listener: _resource_record_pre_action 22:21:12 INFO - Running main action method: clobber 22:21:12 INFO - rmtree: /builds/slave/test/build 22:21:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:21:13 INFO - Running post-action listener: _resource_record_post_action 22:21:13 INFO - [mozharness: 2016-11-18 06:21:13.425500Z] Finished clobber step (success) 22:21:13 INFO - [mozharness: 2016-11-18 06:21:13.425600Z] Running read-buildbot-config step. 22:21:13 INFO - Running pre-action listener: _resource_record_pre_action 22:21:13 INFO - Running main action method: read_buildbot_config 22:21:13 INFO - Using buildbot properties: 22:21:13 INFO - { 22:21:13 INFO - "project": "", 22:21:13 INFO - "product": "firefox", 22:21:13 INFO - "script_repo_revision": "production", 22:21:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:21:13 INFO - "repository": "", 22:21:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:21:13 INFO - "buildid": "20161117193213", 22:21:13 INFO - "pgo_build": "True", 22:21:13 INFO - "basedir": "/builds/slave/test", 22:21:13 INFO - "buildnumber": 196, 22:21:13 INFO - "slavename": "talos-linux64-ix-061", 22:21:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:21:13 INFO - "platform": "ubuntu64_hw", 22:21:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:21:13 INFO - "branch": "mozilla-central", 22:21:13 INFO - "repo_path": "mozilla-central", 22:21:13 INFO - "revision": "8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a", 22:21:13 INFO - "stage_platform": "linux64-pgo", 22:21:13 INFO - "builduid": "83be7b5830364cf586806b65848ad775", 22:21:13 INFO - "slavebuilddir": "test" 22:21:13 INFO - } 22:21:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:21:13 INFO - Running post-action listener: _resource_record_post_action 22:21:13 INFO - [mozharness: 2016-11-18 06:21:13.428021Z] Finished read-buildbot-config step (success) 22:21:13 INFO - [mozharness: 2016-11-18 06:21:13.428110Z] Running download-and-extract step. 22:21:13 INFO - Running pre-action listener: _resource_record_pre_action 22:21:13 INFO - Running main action method: download_and_extract 22:21:13 INFO - mkdir: /builds/slave/test/build/tests 22:21:13 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')]} 22:21:13 INFO - trying https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:21:13 INFO - Downloaded 1361 bytes. 22:21:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:21:13 INFO - Using the following test package requirements: 22:21:13 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:21:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:21:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:21:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'jsshell-linux-x86_64.zip'], 22:21:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:21:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:21:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:21:13 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:21:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:21:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:21:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:21:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:21:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:21:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:21:13 INFO - Fetch https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:21:14 INFO - Http code: 200 22:21:14 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 22:21:14 INFO - x-amz-cf-id: 03MNtNL2auIHwAoHry_VwP4_E6d-17RSSC2SvsGC-bIgLyvese4BBw== 22:21:14 INFO - x-amz-version-id: dS1RxMuZkgXXEc6tDiCiUFoVxuXpi4lt 22:21:14 INFO - Expected file size: 21864679 22:21:14 INFO - Obtained file size: 21864679 22:21:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:21:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:21:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:21:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:21:19 INFO - Http code: 200 22:21:19 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 22:21:19 INFO - x-amz-cf-id: LKQUNx8xdXaexD6vMY0-e9kdFaWK9OoBIn2V7QwAVsR1_smILNdhzQ== 22:21:19 INFO - x-amz-version-id: dS1RxMuZkgXXEc6tDiCiUFoVxuXpi4lt 22:21:19 INFO - Expected file size: 21864679 22:21:19 INFO - Obtained file size: 21864679 22:21:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:21:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:21:24 INFO - Fetch https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:21:24 INFO - Http code: 200 22:21:24 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 22:21:24 INFO - x-amz-cf-id: pgqZjywuOXwE5urJ_9c8An0Ryj8zI8npfbDl3Lu2oap6xdTjgdVzxA== 22:21:24 INFO - x-amz-version-id: nyOJorvh_hl9uqtFA.JEpnbb42xyjUIu 22:21:25 INFO - Expected file size: 14409392 22:21:25 INFO - Obtained file size: 14409392 22:21:25 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')]} 22:21:25 INFO - trying https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:21:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:21:28 INFO - Downloaded 59550356 bytes. 22:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:21:28 INFO - mkdir: /builds/slave/test/properties 22:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 22:21:28 INFO - Contents: 22:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:21:29 INFO - Running post-action listener: _resource_record_post_action 22:21:29 INFO - Running post-action listener: set_extra_try_arguments 22:21:29 INFO - [mozharness: 2016-11-18 06:21:29.160004Z] Finished download-and-extract step (success) 22:21:29 INFO - [mozharness: 2016-11-18 06:21:29.160229Z] Running populate-webroot step. 22:21:29 INFO - Running pre-action listener: _resource_record_pre_action 22:21:29 INFO - Running main action method: populate_webroot 22:21:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:21:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:21:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:21:29 INFO - '--tppagecycles', 22:21:29 INFO - '7'], 22:21:29 INFO - 'tests': ['tsvgm']}}, 22:21:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:21:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:21:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:21:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:21:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:21:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:21:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['damp', 'tps']}, 22:21:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'tests': ['damp', 'tps']}, 22:21:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['dromaeo_dom']}, 22:21:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:21:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['basic_compositor_video']}, 22:21:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:21:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'other-e10s': {'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['a11yr', 22:21:29 INFO - 'ts_paint', 22:21:29 INFO - 'tpaint', 22:21:29 INFO - 'sessionrestore', 22:21:29 INFO - 'sessionrestore_no_auto_restore', 22:21:29 INFO - 'tabpaint']}, 22:21:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['tsvgx', 22:21:29 INFO - 'tsvgr_opacity', 22:21:29 INFO - 'tart', 22:21:29 INFO - 'tscrollx', 22:21:29 INFO - 'cart']}, 22:21:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:21:29 INFO - 'tsvgr_opacity', 22:21:29 INFO - 'tart', 22:21:29 INFO - 'tscrollx', 22:21:29 INFO - 'cart']}, 22:21:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'talos_options': ['--disable-e10s'], 22:21:29 INFO - 'tests': ['tp5o']}, 22:21:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:21:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'talos_options': ['--disable-e10s', 22:21:29 INFO - '--xperf_path', 22:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:21:29 INFO - 'tests': ['tp5n']}, 22:21:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:21:29 INFO - 'talos_options': ['--xperf_path', 22:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:21:29 INFO - 'tests': ['tp5n']}}, 22:21:29 INFO - 'talos.zip': {'path': '', 22:21:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:21:29 INFO - Running post-action listener: _resource_record_post_action 22:21:29 INFO - [mozharness: 2016-11-18 06:21:29.177046Z] Finished populate-webroot step (success) 22:21:29 INFO - [mozharness: 2016-11-18 06:21:29.177134Z] Running create-virtualenv step. 22:21:29 INFO - Running pre-action listener: _resource_record_pre_action 22:21:29 INFO - Running main action method: create_virtualenv 22:21:29 INFO - Creating virtualenv /builds/slave/test/build/venv 22:21:29 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 22:21:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:21:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:21:29 INFO - Using real prefix '/usr' 22:21:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 22:21:31 INFO - Installing pip.................done. 22:21:31 INFO - Return code: 0 22:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:21:31 INFO - Reading from file tmpfile_stdout 22:21:31 INFO - Output received: 22:21:31 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) 22:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:21:31 INFO - Using env: {'DISPLAY': ':0', 22:21:31 INFO - 'HOME': '/home/cltbld', 22:21:31 INFO - 'LANG': 'en_US.UTF-8', 22:21:31 INFO - 'LANGUAGE': 'en_US:en', 22:21:31 INFO - 'LOGNAME': 'cltbld', 22:21:31 INFO - 'MAIL': '/var/mail/cltbld', 22:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:31 INFO - 'MOZ_NO_REMOTE': '1', 22:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:31 INFO - 'NO_EM_RESTART': '1', 22:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:31 INFO - 'PWD': '/builds/slave/test', 22:21:31 INFO - 'SHELL': '/bin/bash', 22:21:31 INFO - 'SHLVL': '1', 22:21:31 INFO - 'TERM': 'linux', 22:21:31 INFO - 'TMOUT': '86400', 22:21:31 INFO - 'USER': 'cltbld', 22:21:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:31 INFO - '_': '/tools/buildbot/bin/python'} 22:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:32 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 22:21:32 INFO - Cleaning up... 22:21:32 INFO - Return code: 0 22:21:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:21: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')]} 22:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21: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')]} 22:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:32 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:32 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 22:21:32 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 22:21:32 INFO - Using env: {'DISPLAY': ':0', 22:21:32 INFO - 'HOME': '/home/cltbld', 22:21:32 INFO - 'LANG': 'en_US.UTF-8', 22:21:32 INFO - 'LANGUAGE': 'en_US:en', 22:21:32 INFO - 'LOGNAME': 'cltbld', 22:21:32 INFO - 'MAIL': '/var/mail/cltbld', 22:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:32 INFO - 'MOZ_NO_REMOTE': '1', 22:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:32 INFO - 'NO_EM_RESTART': '1', 22:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:32 INFO - 'PWD': '/builds/slave/test', 22:21:32 INFO - 'SHELL': '/bin/bash', 22:21:32 INFO - 'SHLVL': '1', 22:21:32 INFO - 'TERM': 'linux', 22:21:32 INFO - 'TMOUT': '86400', 22:21:32 INFO - 'USER': 'cltbld', 22:21:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:32 INFO - '_': '/tools/buildbot/bin/python'} 22:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:32 INFO - Downloading/unpacking psutil>=3.1.1 22:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:21:34 INFO - Installing collected packages: psutil 22:21:34 INFO - Running setup.py install for psutil 22:21:34 INFO - building 'psutil._psutil_linux' extension 22:21:34 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 22:21:34 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 22:21:34 INFO - building 'psutil._psutil_posix' extension 22:21:34 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 22:21:34 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 22:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:21:34 INFO - Successfully installed psutil 22:21:34 INFO - Cleaning up... 22:21:35 INFO - Return code: 0 22:21:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:35 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:35 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 22:21:35 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 22:21:35 INFO - Using env: {'DISPLAY': ':0', 22:21:35 INFO - 'HOME': '/home/cltbld', 22:21:35 INFO - 'LANG': 'en_US.UTF-8', 22:21:35 INFO - 'LANGUAGE': 'en_US:en', 22:21:35 INFO - 'LOGNAME': 'cltbld', 22:21:35 INFO - 'MAIL': '/var/mail/cltbld', 22:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:35 INFO - 'MOZ_NO_REMOTE': '1', 22:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:35 INFO - 'NO_EM_RESTART': '1', 22:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:35 INFO - 'PWD': '/builds/slave/test', 22:21:35 INFO - 'SHELL': '/bin/bash', 22:21:35 INFO - 'SHLVL': '1', 22:21:35 INFO - 'TERM': 'linux', 22:21:35 INFO - 'TMOUT': '86400', 22:21:35 INFO - 'USER': 'cltbld', 22:21:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:35 INFO - '_': '/tools/buildbot/bin/python'} 22:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:21:35 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 22:21:35 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 22:21:35 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 22:21:35 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 22:21:35 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 22:21:35 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 22:21:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:21:37 INFO - Installing collected packages: mozsystemmonitor 22:21:37 INFO - Running setup.py install for mozsystemmonitor 22:21:37 INFO - Successfully installed mozsystemmonitor 22:21:37 INFO - Cleaning up... 22:21:37 INFO - Return code: 0 22:21:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:21:37 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')]} 22:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:37 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')]} 22:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:37 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:37 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 22:21:37 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 22:21:37 INFO - Using env: {'DISPLAY': ':0', 22:21:37 INFO - 'HOME': '/home/cltbld', 22:21:37 INFO - 'LANG': 'en_US.UTF-8', 22:21:37 INFO - 'LANGUAGE': 'en_US:en', 22:21:37 INFO - 'LOGNAME': 'cltbld', 22:21:37 INFO - 'MAIL': '/var/mail/cltbld', 22:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:37 INFO - 'MOZ_NO_REMOTE': '1', 22:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:37 INFO - 'NO_EM_RESTART': '1', 22:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:37 INFO - 'PWD': '/builds/slave/test', 22:21:37 INFO - 'SHELL': '/bin/bash', 22:21:37 INFO - 'SHLVL': '1', 22:21:37 INFO - 'TERM': 'linux', 22:21:37 INFO - 'TMOUT': '86400', 22:21:37 INFO - 'USER': 'cltbld', 22:21:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:37 INFO - '_': '/tools/buildbot/bin/python'} 22:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:37 INFO - Downloading/unpacking jsonschema==2.5.1 22:21:37 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 22:21:37 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 22:21:37 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 22:21:37 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 22:21:37 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 22:21:37 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 22:21:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:21:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:21:39 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 22:21:39 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 22:21:39 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 22:21:39 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 22:21:39 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 22:21:39 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 22:21:39 INFO - Downloading functools32-3.2.3-2.tar.gz 22:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:21:39 INFO - warning: no files found matching '*.txt' 22:21:39 INFO - no previously-included directories found matching 'build' 22:21:39 INFO - no previously-included directories found matching 'dist' 22:21:39 INFO - no previously-included directories found matching '.git*' 22:21:39 INFO - Installing collected packages: jsonschema, functools32 22:21:39 INFO - Running setup.py install for functools32 22:21:39 INFO - warning: no files found matching '*.txt' 22:21:39 INFO - no previously-included directories found matching 'build' 22:21:39 INFO - no previously-included directories found matching 'dist' 22:21:39 INFO - no previously-included directories found matching '.git*' 22:21:39 INFO - Successfully installed jsonschema functools32 22:21:39 INFO - Cleaning up... 22:21:39 INFO - Return code: 0 22:21:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:39 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:39 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 22:21:39 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 22:21:39 INFO - Using env: {'DISPLAY': ':0', 22:21:39 INFO - 'HOME': '/home/cltbld', 22:21:40 INFO - 'LANG': 'en_US.UTF-8', 22:21:40 INFO - 'LANGUAGE': 'en_US:en', 22:21:40 INFO - 'LOGNAME': 'cltbld', 22:21:40 INFO - 'MAIL': '/var/mail/cltbld', 22:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:40 INFO - 'MOZ_NO_REMOTE': '1', 22:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:40 INFO - 'NO_EM_RESTART': '1', 22:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:40 INFO - 'PWD': '/builds/slave/test', 22:21:40 INFO - 'SHELL': '/bin/bash', 22:21:40 INFO - 'SHLVL': '1', 22:21:40 INFO - 'TERM': 'linux', 22:21:40 INFO - 'TMOUT': '86400', 22:21:40 INFO - 'USER': 'cltbld', 22:21:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:40 INFO - '_': '/tools/buildbot/bin/python'} 22:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:21:40 INFO - Cleaning up... 22:21:40 INFO - Return code: 0 22:21:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:21: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')]} 22:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21: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')]} 22:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:40 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:40 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 22:21:40 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 22:21:40 INFO - Using env: {'DISPLAY': ':0', 22:21:40 INFO - 'HOME': '/home/cltbld', 22:21:40 INFO - 'LANG': 'en_US.UTF-8', 22:21:40 INFO - 'LANGUAGE': 'en_US:en', 22:21:40 INFO - 'LOGNAME': 'cltbld', 22:21:40 INFO - 'MAIL': '/var/mail/cltbld', 22:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:40 INFO - 'MOZ_NO_REMOTE': '1', 22:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:40 INFO - 'NO_EM_RESTART': '1', 22:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:40 INFO - 'PWD': '/builds/slave/test', 22:21:40 INFO - 'SHELL': '/bin/bash', 22:21:40 INFO - 'SHLVL': '1', 22:21:40 INFO - 'TERM': 'linux', 22:21:40 INFO - 'TMOUT': '86400', 22:21:40 INFO - 'USER': 'cltbld', 22:21:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:40 INFO - '_': '/tools/buildbot/bin/python'} 22:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:40 INFO - Downloading/unpacking blobuploader==1.2.4 22:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:21:42 INFO - Downloading blobuploader-1.2.4.tar.gz 22:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:21:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:21:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:42 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 22:21:43 INFO - Downloading docopt-0.6.1.tar.gz 22:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:21:43 INFO - Installing collected packages: blobuploader, requests, docopt 22:21:43 INFO - Running setup.py install for blobuploader 22:21:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:21:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:21:43 INFO - Running setup.py install for requests 22:21:43 INFO - Running setup.py install for docopt 22:21:43 INFO - Successfully installed blobuploader requests docopt 22:21:43 INFO - Cleaning up... 22:21:43 INFO - Return code: 0 22:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:43 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:43 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 22:21:43 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 22:21:43 INFO - Using env: {'DISPLAY': ':0', 22:21:43 INFO - 'HOME': '/home/cltbld', 22:21:43 INFO - 'LANG': 'en_US.UTF-8', 22:21:43 INFO - 'LANGUAGE': 'en_US:en', 22:21:43 INFO - 'LOGNAME': 'cltbld', 22:21:43 INFO - 'MAIL': '/var/mail/cltbld', 22:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:43 INFO - 'MOZ_NO_REMOTE': '1', 22:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:43 INFO - 'NO_EM_RESTART': '1', 22:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:43 INFO - 'PWD': '/builds/slave/test', 22:21:43 INFO - 'SHELL': '/bin/bash', 22:21:43 INFO - 'SHLVL': '1', 22:21:43 INFO - 'TERM': 'linux', 22:21:43 INFO - 'TMOUT': '86400', 22:21:43 INFO - 'USER': 'cltbld', 22:21:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:43 INFO - '_': '/tools/buildbot/bin/python'} 22:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:21:43 INFO - Running setup.py (path:/tmp/pip-MMy5Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:21:44 INFO - Running setup.py (path:/tmp/pip-5yxN99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:21:44 INFO - Running setup.py (path:/tmp/pip-nnYR9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:21:44 INFO - Running setup.py (path:/tmp/pip-Z8zhex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:21:44 INFO - Running setup.py (path:/tmp/pip-py8qLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:21:44 INFO - Running setup.py (path:/tmp/pip-mR1iLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:21:44 INFO - Running setup.py (path:/tmp/pip-2jAM8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:21:44 INFO - Running setup.py (path:/tmp/pip-7HpV03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:21:44 INFO - Running setup.py (path:/tmp/pip-dzgEap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:21:44 INFO - Running setup.py (path:/tmp/pip-83Bx7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:21:44 INFO - Running setup.py (path:/tmp/pip-eUTsro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:21:44 INFO - Running setup.py (path:/tmp/pip-Y9OcjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:21:44 INFO - Running setup.py (path:/tmp/pip-Bm6R1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:21:44 INFO - Running setup.py (path:/tmp/pip-WotI4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:45 INFO - Running setup.py (path:/tmp/pip-EZz6Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:21:45 INFO - Running setup.py (path:/tmp/pip-I5QV6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:21:45 INFO - Running setup.py (path:/tmp/pip-vryx_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:21:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:21:45 INFO - Running setup.py install for manifestparser 22:21:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:21:45 INFO - Running setup.py install for mozcrash 22:21:45 INFO - Running setup.py install for mozdebug 22:21:45 INFO - Running setup.py install for mozdevice 22:21:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:21:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:21:45 INFO - Running setup.py install for mozfile 22:21:45 INFO - Running setup.py install for mozhttpd 22:21:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:21:45 INFO - Running setup.py install for mozinfo 22:21:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:21:45 INFO - Running setup.py install for mozInstall 22:21:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Running setup.py install for mozleak 22:21:46 INFO - Running setup.py install for mozlog 22:21:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Running setup.py install for moznetwork 22:21:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Running setup.py install for mozprocess 22:21:46 INFO - Running setup.py install for mozprofile 22:21:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Running setup.py install for mozrunner 22:21:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Running setup.py install for mozscreenshot 22:21:46 INFO - Running setup.py install for moztest 22:21:46 INFO - Running setup.py install for mozversion 22:21:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:21:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:21:46 INFO - Cleaning up... 22:21:47 INFO - Return code: 0 22:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21:47 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')]} 22:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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')]} 22:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:47 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:47 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 22:21:47 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 22:21:47 INFO - Using env: {'DISPLAY': ':0', 22:21:47 INFO - 'HOME': '/home/cltbld', 22:21:47 INFO - 'LANG': 'en_US.UTF-8', 22:21:47 INFO - 'LANGUAGE': 'en_US:en', 22:21:47 INFO - 'LOGNAME': 'cltbld', 22:21:47 INFO - 'MAIL': '/var/mail/cltbld', 22:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:47 INFO - 'MOZ_NO_REMOTE': '1', 22:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:47 INFO - 'NO_EM_RESTART': '1', 22:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:47 INFO - 'PWD': '/builds/slave/test', 22:21:47 INFO - 'SHELL': '/bin/bash', 22:21:47 INFO - 'SHLVL': '1', 22:21:47 INFO - 'TERM': 'linux', 22:21:47 INFO - 'TMOUT': '86400', 22:21:47 INFO - 'USER': 'cltbld', 22:21:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:47 INFO - '_': '/tools/buildbot/bin/python'} 22:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:21:47 INFO - Running setup.py (path:/tmp/pip-SAsbYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:21:47 INFO - Running setup.py (path:/tmp/pip-F1c6tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:21:47 INFO - Running setup.py (path:/tmp/pip-EgvcqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:21:47 INFO - Running setup.py (path:/tmp/pip-r3wCJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:21:47 INFO - Running setup.py (path:/tmp/pip-y39FUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:21:47 INFO - Running setup.py (path:/tmp/pip-lJKJjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:21:47 INFO - Running setup.py (path:/tmp/pip-zZDTWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:21:47 INFO - Running setup.py (path:/tmp/pip-V2JcUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:21:47 INFO - Running setup.py (path:/tmp/pip-5jxkff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:21:47 INFO - Running setup.py (path:/tmp/pip-T2Dg8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:21:47 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)) 22:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:21:47 INFO - Running setup.py (path:/tmp/pip-MeKotQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:21:48 INFO - Running setup.py (path:/tmp/pip-jq0kVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:21:48 INFO - Running setup.py (path:/tmp/pip-ZhEmNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:21:48 INFO - Running setup.py (path:/tmp/pip-fN_j3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:48 INFO - Running setup.py (path:/tmp/pip-PIQn_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:21:48 INFO - Running setup.py (path:/tmp/pip-MccQKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:21:48 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)) 22:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:21:48 INFO - Running setup.py (path:/tmp/pip-gInaop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:21:48 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)) 22:21:48 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)) 22:21:48 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)) 22:21:48 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)) 22:21:48 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)) 22:21:48 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)) 22:21:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:21:48 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 22:21:48 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 22:21:48 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 22:21:48 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 22:21:48 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 22:21:48 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 22:21:50 INFO - Downloading blessings-1.6.tar.gz 22:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:21:50 INFO - Installing collected packages: blessings 22:21:50 INFO - Running setup.py install for blessings 22:21:50 INFO - Successfully installed blessings 22:21:50 INFO - Cleaning up... 22:21:50 INFO - Return code: 0 22:21:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:21:50 INFO - Reading from file tmpfile_stdout 22:21:50 INFO - Current package versions: 22:21:50 INFO - argparse == 1.2.1 22:21:50 INFO - blessings == 1.6 22:21:50 INFO - blobuploader == 1.2.4 22:21:50 INFO - docopt == 0.6.1 22:21:50 INFO - functools32 == 3.2.3-2 22:21:50 INFO - jsonschema == 2.5.1 22:21:50 INFO - manifestparser == 1.1 22:21:50 INFO - mozInstall == 1.12 22:21:50 INFO - mozcrash == 1.0 22:21:50 INFO - mozdebug == 0.1 22:21:50 INFO - mozdevice == 0.48 22:21:50 INFO - mozfile == 1.2 22:21:50 INFO - mozhttpd == 0.7 22:21:50 INFO - mozinfo == 0.9 22:21:50 INFO - mozleak == 0.1 22:21:50 INFO - mozlog == 3.4 22:21:50 INFO - moznetwork == 0.27 22:21:50 INFO - mozprocess == 0.23 22:21:50 INFO - mozprofile == 0.28 22:21:50 INFO - mozrunner == 6.13 22:21:50 INFO - mozscreenshot == 0.1 22:21:50 INFO - mozsystemmonitor == 0.3 22:21:50 INFO - moztest == 0.7 22:21:50 INFO - mozversion == 1.4 22:21:50 INFO - psutil == 3.1.1 22:21:50 INFO - requests == 1.2.3 22:21:50 INFO - wsgiref == 0.1.2 22:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:21:50 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')]} 22:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:50 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')]} 22:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:50 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:50 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 22:21:50 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 22:21:50 INFO - Using env: {'DISPLAY': ':0', 22:21:50 INFO - 'HOME': '/home/cltbld', 22:21:50 INFO - 'LANG': 'en_US.UTF-8', 22:21:50 INFO - 'LANGUAGE': 'en_US:en', 22:21:50 INFO - 'LOGNAME': 'cltbld', 22:21:50 INFO - 'MAIL': '/var/mail/cltbld', 22:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:50 INFO - 'MOZ_NO_REMOTE': '1', 22:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:50 INFO - 'NO_EM_RESTART': '1', 22:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:50 INFO - 'PWD': '/builds/slave/test', 22:21:50 INFO - 'SHELL': '/bin/bash', 22:21:50 INFO - 'SHLVL': '1', 22:21:50 INFO - 'TERM': 'linux', 22:21:50 INFO - 'TMOUT': '86400', 22:21:50 INFO - 'USER': 'cltbld', 22:21:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:50 INFO - '_': '/tools/buildbot/bin/python'} 22:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 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)) 22:21:51 INFO - Cleaning up... 22:21:51 INFO - Return code: 0 22:21:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:21:51 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 0x7f3b68f5ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, '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': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', '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 22:21:51 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 22:21:51 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 22:21:51 INFO - Using env: {'DISPLAY': ':0', 22:21:51 INFO - 'HOME': '/home/cltbld', 22:21:51 INFO - 'LANG': 'en_US.UTF-8', 22:21:51 INFO - 'LANGUAGE': 'en_US:en', 22:21:51 INFO - 'LOGNAME': 'cltbld', 22:21:51 INFO - 'MAIL': '/var/mail/cltbld', 22:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:51 INFO - 'MOZ_NO_REMOTE': '1', 22:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:51 INFO - 'NO_EM_RESTART': '1', 22:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:51 INFO - 'PWD': '/builds/slave/test', 22:21:51 INFO - 'SHELL': '/bin/bash', 22:21:51 INFO - 'SHLVL': '1', 22:21:51 INFO - 'TERM': 'linux', 22:21:51 INFO - 'TMOUT': '86400', 22:21:51 INFO - 'USER': 'cltbld', 22:21:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:51 INFO - '_': '/tools/buildbot/bin/python'} 22:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:21:51 INFO - Cleaning up... 22:21:51 INFO - Return code: 0 22:21:51 INFO - Running post-action listener: _resource_record_post_action 22:21:51 INFO - Running post-action listener: _start_resource_monitoring 22:21:51 INFO - Starting resource monitoring. 22:21:51 INFO - [mozharness: 2016-11-18 06:21:51.382639Z] Finished create-virtualenv step (success) 22:21:51 INFO - [mozharness: 2016-11-18 06:21:51.383116Z] Running install step. 22:21:51 INFO - Running pre-action listener: _resource_record_pre_action 22:21:51 INFO - Running main action method: install 22:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:21:51 INFO - Reading from file tmpfile_stdout 22:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 22:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:21:51 INFO - Reading from file tmpfile_stdout 22:21:51 INFO - Output received: 22:21:51 INFO - Usage: mozinstall [options] installer 22:21:51 INFO - Options: 22:21:51 INFO - -h, --help show this help message and exit 22:21:51 INFO - -d DEST, --destination=DEST 22:21:51 INFO - Directory to install application into. [default: 22:21:51 INFO - "/builds/slave/test"] 22:21:51 INFO - --app=APP Application being installed. [default: firefox] 22:21:51 INFO - mkdir: /builds/slave/test/build/application 22:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:22:09 INFO - Reading from file tmpfile_stdout 22:22:09 INFO - Output received: 22:22:09 INFO - /builds/slave/test/build/application/firefox/firefox 22:22:09 INFO - Running post-action listener: _resource_record_post_action 22:22:09 INFO - [mozharness: 2016-11-18 06:22:09.335434Z] Finished install step (success) 22:22:09 INFO - [mozharness: 2016-11-18 06:22:09.335677Z] Running run-tests step. 22:22:09 INFO - Running pre-action listener: _resource_record_pre_action 22:22:09 INFO - Running main action method: run_tests 22:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:22:09 INFO - Python 2.7.3 22:22:09 INFO - Return code: 0 22:22:09 INFO - grabbing minidump binary from tooltool 22:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:09 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 0x28ddfc0>, '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 0x28deec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28df350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:22:09 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 22:22:09 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 22:22:09 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 22:22:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:22:09 INFO - Return code: 0 22:22:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:22:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:22:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:22:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:22:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:22:09 INFO - Using env: {'DISPLAY': ':0', 22:22:09 INFO - 'HOME': '/home/cltbld', 22:22:09 INFO - 'LANG': 'en_US.UTF-8', 22:22:09 INFO - 'LANGUAGE': 'en_US:en', 22:22:09 INFO - 'LOGNAME': 'cltbld', 22:22:09 INFO - 'MAIL': '/var/mail/cltbld', 22:22:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:22:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:09 INFO - 'MOZ_NO_REMOTE': '1', 22:22:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:09 INFO - 'NO_EM_RESTART': '1', 22:22:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:09 INFO - 'PWD': '/builds/slave/test', 22:22:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:22:09 INFO - 'SHELL': '/bin/bash', 22:22:09 INFO - 'SHLVL': '1', 22:22:09 INFO - 'TERM': 'linux', 22:22:09 INFO - 'TMOUT': '86400', 22:22:09 INFO - 'USER': 'cltbld', 22:22:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996', 22:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:09 INFO - '_': '/tools/buildbot/bin/python'} 22:22:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:22:09 INFO - mozversion application_buildid: 20161117193213 22:22:09 INFO - mozversion application_changeset: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a 22:22:09 INFO - mozversion application_display_name: Nightly 22:22:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:22:09 INFO - mozversion application_name: Firefox 22:22:09 INFO - mozversion application_remotingname: firefox 22:22:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:22:09 INFO - mozversion application_vendor: Mozilla 22:22:09 INFO - mozversion application_version: 53.0a1 22:22:09 INFO - mozversion platform_buildid: 20161117193213 22:22:09 INFO - mozversion platform_changeset: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a 22:22:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:22:09 INFO - mozversion platform_version: 53.0a1 22:22:09 INFO - using testdate: 1479450129 22:22:09 INFO - actual date: 1479450129 22:22:09 INFO - starting webserver on 'localhost:36993' 22:22:09 INFO - SUITE-START | Running 2 tests 22:22:09 INFO - TEST-START | dromaeo_css 22:22:09 INFO - operating with platform_type : linux_ 22:22:09 INFO - Initialising browser for dromaeo_css test... 22:22:09 INFO - TEST-INFO | started process 18231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtBdYy/profile http://localhost:36993/getInfo.html) 22:22:14 INFO - PROCESS | 18231 | __metrics Screen width/height:1600/1200 22:22:14 INFO - PROCESS | 18231 | colorDepth:24 22:22:14 INFO - PROCESS | 18231 | Browser inner width/height: 1024/697 22:22:14 INFO - PROCESS | 18231 | __metrics 22:22:15 ERROR - PROCESS | 18231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 22:22:16 INFO - TEST-INFO | 18231: exit 0 22:22:16 INFO - Browser initialized. 22:22:16 INFO - Running cycle 1/1 for dromaeo_css test... 22:22:16 INFO - TEST-INFO | started process 18357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtBdYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:22:28 INFO - PROCESS | 18357 | RSS: Main: 185765888 22:22:28 INFO - PROCESS | 18357 | 22:23:17 INFO - PROCESS | 18357 | 1479450197872 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] 22:25:29 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36993/tests/dromaeo/cssquery-ext.html) 22:25:31 INFO - PROCESS | 18357 | RSS: Main: 198791168 22:25:31 INFO - PROCESS | 18357 | 22:28:33 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-ext.html (next: http://localhost:36993/tests/dromaeo/cssquery-jquery.html) 22:28:33 INFO - PROCESS | 18357 | RSS: Main: 196591616 22:28:33 INFO - PROCESS | 18357 | 22:31:35 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36993/tests/dromaeo/cssquery-mootools.html) 22:31:36 INFO - PROCESS | 18357 | RSS: Main: 198664192 22:31:36 INFO - PROCESS | 18357 | 22:34:38 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36993/tests/dromaeo/cssquery-prototype.html) 22:34:39 INFO - PROCESS | 18357 | RSS: Main: 195616768 22:34:39 INFO - PROCESS | 18357 | 22:37:41 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36993/tests/dromaeo/cssquery-yui.html) 22:37:42 INFO - PROCESS | 18357 | RSS: Main: 199024640 22:37:42 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:36993/tests/dromaeo/cssquery-yui.html (next: http://localhost:36993/tests/dromaeo/cssquery-dojo.html) 22:40:45 INFO - PROCESS | 18357 | RSS: Main: 198762496 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | __start_tp_report 22:40:45 INFO - PROCESS | 18357 | _x_x_mozilla_page_load 22:40:45 INFO - PROCESS | 18357 | _x_x_mozilla_page_load_details 22:40:45 INFO - PROCESS | 18357 | |i|pagename|runs| 22:40:45 INFO - PROCESS | 18357 | |0;dojo.html;3175.079227024163;3179.332340208555;3191.904242872713;3223.5809344785175;3225.1292151119196;5448.155535891943;5449.427810079944;5481.479259470354;5501.229827824108;5550;5393.81121660741;5447.264619276397;5502.614816962814;5521;5543.695096769686;4970.627202959774;4991.351124353829;5016.448190699039;5070.822521211759;5128.71792051437;4936.33359496467;5039.21892106724;5069.847904562869;5075.289459475676;5128.358955130609;4881.926771098437;4933.161362568372;5036.748162591855;5075.6447048706605;5085.033843569729;4988.376452943382;4995.150824359867;4996.150654388763;5002.299678045077;5014.749262536859;4931.482194369575;4938.975305123451;4943.4809345018975;4947.579455746266;4951.62862785289;5382.6232163748555;5421.349438067417;5428.945710542884;5438.700871452069;5516;5910.615809972381;5920.319163296233;5934.37689042653;5959.22530071088;5962.224910761616;5927.555433342473;5950.642961422329;5953.970230148865;5957.374475680034;5958.076498142751;5372.194170874322;5399.487048730364;5468.152436372368;5536.501714845643;5537.723113844291;5893.410658934073;5938.584299099108;5956.047032474783;5966.850828729316;5973.940260597426;5791.797287095016;5824.068149096124;5824.184614154022;5873.383294754075;5936.703164841827;5941.168236446901;5951.642901425928;5970.34326224115;5970.611910225822;5973.731182096729;5769.740361683735;5773.769049237983;5807.303123625192;5810.448007439287;5872.207252021008;5821.126830975303;5849.181114643953;5866.882662346729;5927.792527261611;5935.436133567304;4472.44094488189;4475.194464996332;4503.369528266046;4507.076049409863;4534.752942940718;3939.783311917872;3973.6225058619384;4019.1157945252;4033.9596604033586;4048.5344185419053;5623.887522249532;5691.9146212806845;5698.344690360579;5737.684427356536;5750.993576124161;5941;5978.28260608721;5990.011648078105;6002.549808764273;6014.338422773491;5441.5102640762525;5487.670739755547;5670.943290567042;5709.200711900337;5709.200711900337;5016.44819069902;5045.495450454999;5067.847964561069;5095.363079615048;5107.463716309809;5967.582269241198;5987.910181347196;6043.54673399488;6089.391060893875;6117.541184411098;5837.29952405714;5850.0932355484965;5880.441358070976;5887.470127688529;5906.40935906406;6010.2186715726675;6019.939800601938;6032.366601506778;6057.697115144137;6062.302835174011;5608.747606357642;5626.24045753818;5635.971820140873;5727.4845263926445;5782.5663075268685;5900.675462849413;5912.290525137011;5951.315598706205;5998.490128338965;6045.637261764308;5770.451807078321;5803.65178089316;5813.15709222152;5821.505172060253;5827.825165245049;5613.943860561505;5820;5821.417858214314;5825.3883342248455;5834.854128646818;5543.944560554342;5580.525655319343;5588.972055139699;5617.578681598815;5678.971605142113;5740.39725828782;5761.107028410603;5768.365479797135;5782.3639399666845;5826.388229235869;5605.299337582802;5632.633878797865;5649.4350564944825;5657.547396208376;5683.687397193194 22:40:45 INFO - PROCESS | 18357 | |1;ext.html;567.5573053018645;580.09794769134;588.9204957330759;595.5741644724025;602.8131279303416;40177.397339039904;41459.585404145946;41506.58493415065;43631.34552981708;43748.78125609375;42252.788736056275;42622.36066459006;42721.572784272146;43067;43292.350614740804;8475.237228649436;8579.442336248156;8587;8613.138686131368;8637.481751094923;8531.872021919677;8535.231829135377;8600.096989816073;8606.741797746077;8617.310615150773;8612.311015118807;8616.827663446727;8636.093210212932;8686.609102590399;8695.91301087364;8528.530930798803;8569.528675922822;8620.267277281408;8633.223009929137;8647.394682372236;8524.573771311472;8582.356323275779;8593;8595.785105372353;8624.956875215647;40613.59386406127;40976.180476390604;40993.59006409928;41021;41060.38409423861;3401.744869134825;3449.3963556377535;3454.5681789776277;3458.515807786912;3463.3592785334795;30100.24749381261;30268.8486557568;30711.38577228465;31318.530222046687;31847.203819904455;4051.7117215553226;4117.75293482392;4153.626173644387;4154.709170358076;4168.6665066794585;337654;339919;341047;342444;342475;55482.72258638681;56428.946381702284;56502.152467713015;56542;56555;53990.46009539933;54252.45747542553;54486.182707259424;54817.72591137099;55132.17301740477;17053.57366065858;17160.914195428944;17178.82191794522;17220.31118755261;17365;13292.601221963356;13299.93350033263;13317.267550284634;13402.26287554194;13428.798568021488;17239.310427582757;17747;17879.821201788076;18092.638147236983;18253.908730456264;6859.416949559243;6868.313168683192;6927.861442771217;7258.709651613982;7386.2613738625705;853.8633818588996;855.6106971328031;987.1559816356911;1017.9643712470177;1085.6146068145852;31304.84347578293;31378.52932206019;31537.684623153935;31612.209694757814;31863.362732745678;1097.4677281518457;1108.3017698849835;1114.570890207276;1126.0259875207887;1142.8857114288505;15513.84486155124;16289.185540722916;16414.425495107615;16422.75365869513;16611.50165495037;462638;679418;684665;689501;690610;54902.62743431366;55009;55506.44493555013;55650.721746391006;55801.72099139478;1331.5872079655337;1340.8525062243145;1360.5850215684113;1364.8293963254594;1376.7108907129616;29714.70285297206;31407.84296078505;31440;31452;31862.362752745277;47501.52498475109;48248.27627585519;48313.27530086981;48446.5155348442;48669.2699609499;438204;440023;442757;443154;446016;26959;27596.310092247855;27660.58509122405;27673.308167295978;27707.168784936483;45664.54335456603;45861.77069114633;46304.53695463002;46880.53119468762;47518;38995;39396.2120757589;39505.14845546382;39631.80184099061;40911.38632920449;39141.608583913796;39155.60844391634;39724.404133938595;40078.1984360317;40719.38920916248;38094.23811523809;38399.232015360096;40080.3987940187;41360;41374;30842.38315233638;33151.17122071871;34275.4858677125;34357.484637729955;34362;25944;26300.342491437867;26467;26578.46843063089;26882.193534194004 22:40:45 INFO - PROCESS | 18357 | |2;jquery.html;381.95607505136917;398.07844839197276;402.87510871629786;404.7814180342615;415.9787721144588;16065.437709680164;16228.675426491463;17532.82467175328;19173.328933487348;19213.135408906615;18234.45296641103;18743.90628046861;19269.710954335696;19402.70895936562;19571.5107122322;4964.156093464111;4989.3513843200335;5169.3279873616375;5188.948110518903;5213.296205012312;5076.796928122871;5155.81954631588;5156.690598564098;5158.071547121516;5168.3539557555305;5912.615679980809;6176.135341052256;6188.752449901998;6308.747650093991;6323.336049714782;5610.214569960209;5639.2668953036255;6283.246010478726;6330.303666596671;6334.208223972027;5505.981393442186;5511.862203444906;5517;5524.889502209933;5530.2810634617645;13405.396757145854;13557.796633050511;13704;13749.900007999337;13799.103058301178;2233.4081468410886;2279.8290128240283;2288.3478208710603;2321.292005938188;2373.753779265882;9851.262332707372;9979.351342162809;10004.99950005001;10341.689749307458;10422.687319380431;1811.6286161336893;1852.3794528832857;1910.74204982327;1927.267638297452;1999.8800071995581;75635;77236;79595.60202198951;90090.09909900883;90178.54910725405;10303.278770486144;10556.208284378548;10737.731556710989;11154.609588664358;11404.429778511207;15741.22210669454;15756.212189390484;15792.68414631701;15796.289166987513;15802.209889505479;7956;8091.1504292048485;8093.716719914893;8204.302634276153;8249.670013199404;7731.420143489261;7743.148253692089;7760.262775036363;7883.448158628841;7951.165127661628;4651.906961860744;4696.131215725101;4727.834525791581;4777.235642297285;4949.727764972961;1772.9556761081076;1999.8700084494462;2001.599680063993;2032.4756432675492;2064.246550009266;882.1311008656468;914.3051281026335;953.7472569769017;965.7782904625655;1060.9734756630992;18934.337298194772;19276.518087047934;19302.42092737192;19432.611347772967;19788.505287367643;929.7396728915915;944.15498129174;982.2436723722693;993.9204863611038;1039.2205845615788;10096;10706.357618542912;10790.08284295828;10797.622083227207;10835.349879007284;454157;457255;483619;484382;489206;80576;81271;91473.54263228641;97450.51274743582;98348.50825745969;1012.2307046644456;1028.3932479836783;1071.2019545438698;1089.4171618184391;1117.9664610061711;16987.235574398936;17165.458925225452;17362;17485.300587976337;17502.299908003537;42685.5731442694;42757.35863962105;43047.56952430561;43258.35112473378;45279.77360113178;56750.43249567451;57968.420315796306;60820;61001.69499152476;61812;7232.493725439169;7552.207018263223;8203.892474515864;8210.425270231026;8494.617742201492;7348.779536613696;11448.484818183035;11974.820377694168;12503.499860005499;12910.806337905127;11462.426878655868;11612.767744645229;11850.703732406759;11905.940470297593;12174.539055313066;10855.348679079281;10875.619353322596;11050.226484146033;11209.383483908463;11642.592509262135;10973.341599504056;11338.263012904135;11415.429228538706;11931.701707457383;11956.402179891145;7753.689852406066;7820.64807083694;7895.249951254622;7965.362770978192;7990.240927111915;9848.60605575769;11498.48256828428;12103.455344509342;12199.329036903055;12263.75472490563 22:40:45 INFO - PROCESS | 18357 | |3;mootools.html;1432.8996970212083;1461.7880407340936;1569.7017566662341;1701.7532457793627;1713.100622173359;7799.454038217327;7981.600919953994;8203.712870049549;8271.586420678965;8319.625616847241;8267.17328267173;8412.369072319585;8423.284020858218;8430.83138337233;8441.746747597583;2265.954680906381;2293.6100862853355;2299.8045166160814;2300.735415427222;2308.4228942764307;2218.456478162844;2258.3789457899043;2263.660450932365;2276.169198242646;2295.5753185660624;2235.3740952533317;2246.472079061419;2270.7729227077325;2276.931692049241;2277.4534111813127;2233.8436309458343;2241.450844543081;2266.0935625749667;2276.829237807171;2283.7602051784575;2290.5075408787193;2296.0471404367167;2305.2738387407912;2313.306008197551;2314.132200424841;8017.478863873829;8107.22981316774;8195.754127376189;8197.877031844528;8248.298894593907;4888.095702295087;5057.190849464105;5088.058709138784;5101.642884998052;5119.488051194888;3101.9379612407624;3141.2461009357817;3373.4771110477914;3415.3169366126626;3418.67522585354;1085.234909388879;1089.983650245239;1113.9387333696643;1127.4250132432437;1149.2472430557998;11277.32336059839;11348.09215262777;11461.083113350913;11472.139589530818;11472.885271147348;4096.508418989741;4318.395424640553;4352.412424322676;4447.844325448594;4455.844045458393;8871.64513419456;8920.598573064228;9010.504422256708;9036.954815226014;9065.184133428023;4948.084604348207;4969.527894849984;4970.801167953241;4985.626078044161;5016.147254966664;4584.083183363341;4586.518415566385;4698.859034228979;4733.668643194943;4780.95219047805;3566.8038257895546;3684.3552378333684;3687.575928768172;3732.7760334380023;3747.8500859965843;1106.9335839849634;1110.838928355384;1120.6862078618;1129.0346753525782;1131.8245671920865;896.0994200828126;916.1800188830958;919.2921450483224;934.5467448287575;942.7313215733483;5592.161175823578;5736.1682556029145;5744.310682718017;5763.366029736726;5866.384029676908;862.65062649627;906.1708536688856;947.303731757158;955.6225291010012;967.9322447428613;3647.1793846384353;3692.7968961707365;3700.629937006278;3705.1292946157632;3717.8698745544316;9690.70927872165;9957;9998.200143988464;10036.949815250877;10066.396016239049;9923.057309555581;9974.102330790118;9990.600375985025;10009.349392289623;10017.649382271586;7302.48882578225;7465.477416580896;7475.2151024141685;7582.62086895653;7583.469157158946;5389.649672771257;5452.890942181213;5489.780408783604;5643.746031428677;5664.603477756517;9130.817383652156;9311.953440232755;9314.534273286445;9315.441073535609;9402.858957115786;9164.725058248263;9400;9468.95265523668;9470.19503342196;9513.23894088485;6388.840278993062;6565.310642382672;6954.860902781815;7129;7158.46311526648;7676.923230767844;7987.600619969095;8036.718714845187;8079.717209897625;8087.272145506932;6707.765228216989;7125.857482850418;7288.453365997678;7352.632368381453;7431.033965584439;6642.568233064835;6655.23464801554;6738.35985581369;6807.149106361705;6902.206246281541;6118.235220597426;6180.103884936749;6230.252369715663;6232.470240029648;6242.469390101892;4866.221404575251;4873.634477414279;4924.482929292372;4934.111859865116;4955.479674634255;4621.838235661736;4631.374764406762;4722.881927951828;4780.737059461763;4843.539863712942 22:40:45 INFO - PROCESS | 18357 | |4;prototype.html;323.90768630940187;327.6575978102882;338.1883479648841;338.5615627762049;339.58231375408246;5348.358197016354;5485.204645326426;5542.39033706292;5575.10798272276;5621.4940655341015;5185.677652198693;5362.27609272748;5382.501374106832;5397.595180361469;5429.131338985753;4255.340422234543;4276.465441819772;4290.69965102443;4299.742015479082;4311.935320970188;4164.66682665386;4244.596763307481;4245.429191199245;4277.1873344064525;4284.164587905359;4209.557996410379;4217.722429887857;4219.164663371428;4227.450431443908;4236.284304856523;4194.370844373338;4203.747775133471;4215.18525734211;4222.113356195203;4244.851430199959;3693.519842420468;3759.2895232669343;3768.5854555998817;3785.9432108518395;3793.430985352192;5251.159814429711;5264.973675131638;5278.736063196825;5290.523852853262;5357.705326207057;4833.404976357829;4869.247071054418;4877.975625118694;4887.657863949525;4927.975360123212;5540.48179406076;5636.985342638323;5676.722737384055;5684.289463817023;5684.602077854552;4107.774072426016;4125.752454852688;4131.421600975866;4138.02756352257;4160.583941605845;5911.615744976562;5925.762969481216;5928;5938.732757025944;5954.910676339859;4148.282874717065;4230.915381692349;4251.489821221473;4264.744115353089;4268.189044081614;4261.786910654455;4262.509811371732;4265.445492086009;4268.466441694788;4289.742615443083;4825.806967721252;4831.613470922318;4835.95164048362;4838.879028024257;4841.709497430165;5574.832755017356;5641.915371269434;5650.3219613646625;5661.660300381908;5760.94239057604;1433.31917339263;1442.343733601209;1443.7256921184942;1448.630599197198;1451.2743628185908;975.658519518163;1012.9139023182964;1015.6597539824094;1020.897910208988;1029.6807989523122;5323.414424413311;5364.383095943938;5393.6763794172475;5399;5403.378611459732;5671.376148623648;5692;5702.714864256771;5708.942910570924;5729;5256.369235691742;5341.893162136736;5365.54392876602;5536.307961504812;5554.86112847174;2992.713133352636;3028.8939887103847;3034.484137696597;3036.6963303669454;3041.5133578627315;5583.715745378505;5869.325027621793;5917.644941303535;5920.2895652521975;5931.762729490858;5722.284714410699;5770.307563092456;5776.855578610484;5780.479756821906;5784.500377271775;5827.329857066492;5828.5337173026055;5875.882482350415;5889.499392551681;5896.233489646233;5552.861178470571;5695.067040474242;5714.628549144292;5893.941060589339;5925.200097986889;5820.447057529528;5832.337783731616;5877.882442351214;5883.146943693055;5904.3210030845285;5759.971200143972;6096.542759292982;6141.7543298267565;6149;6165.660888651168;4010.9972506873282;4111.938320925129;4162.4796900387455;4236.491621005376;4282.978585107055;5851.590388672752;5856.3558008618165;5858.736356864037;5864.266966629171;5915.733791979457;5616.326040875121;5714.971305165111;5719.256496655408;5723.484886360247;5743.368229494836;5665.943340566541;5699.401562836008;5701.885962280814;5712.857178570569;5717.914231286451;5688.11834165705;5691.117876729114;5711.457411545896;5715.628484148683;5716.5426765859465;5504.688031027058;5684.573656975661;5706.258186435737;5747.712614369349;5762;5591.245181900392;5605.5235304997905;5629.943700562942;5647.943520564741;5676.20533125371 22:40:45 INFO - PROCESS | 18357 | |5;yui.html;716.3409663109938;746.2127455534412;774.7846437285266;796.4703472190994;808.9555074470902;12961.027922905785;13888.37502312396;13897.652558686037;13949.442022319108;13950.930245348773;12713.427895744691;12863.485460581589;12864.485420583165;12876.098673092887;12888.226706397623;645.844997200672;663.3863676099612;740.555666600041;764.663548038864;766.643510767493;774.5778550689887;777.6617171530374;778.3189709004621;779.0573406178531;779.104030365079;828.2835347424494;829.241244261503;830.0910502999207;831.4512421801612;832.5587438657521;825.1006403020676;825.405707890318;825.475822852487;825.5335735309561;826.4586695714316;596.9940300596982;599.7930713903696;604.8457643300974;605.7486143250545;606.0364021206259;12379.75240495194;12386;12403.379831008504;12409.62771116868;12443.564475243413;13992.851608388133;14322.57032289033;14504.41982320706;14592.343344549521;14677.119372837557;9676.274279429072;9886.258530610234;9933.75165620858;9985.950070249603;10019.198464122852;3589.569251689788;3612.8554857805657;3617.2584620152807;3765.4163604641326;3768.434734789776;61488.38511614871;63165;63202;63561.68219158921;64866.3513364865;10838.891611083945;10860.511276992554;10909.23635345534;11073.944630276797;11164.497597607964;20074.39776806698;20107.095180716904;20138.093785779383;20144.194232230548;20219.595608087755;6717.193936727526;7149.7497587584185;7156.821079473055;7264.673089710976;7360.447966402541;4196.538380778112;4305.418768466279;4389.18800021997;4513.661475389359;4553.590176884097;3339.0984434203115;3415.9487607685905;3453.9827300863335;3456.4815277708044;3463.6709512596262;621.3998952696734;643.1092936283281;649.2403887451693;664.259350823828;671.8387586979187;620.7051650466083;662.0929326822285;669.5982410553629;699.9300069993062;724.8296650287178;8659.870101948476;9046.638134474548;9054.728358149267;9169.358144929924;9371.765705857408;621.586644881158;631.251966419794;672.7275453441364;700.5201437015661;702.9683664235122;3847.74989625679;3898.4542164097047;3965.7620542767527;4045.3527435610163;4152.854650087293;70579.6471017652;89542;90730;92187.53906230426;92375.04596638755;77745.61127194327;78314;78347;80079.59960200278;84811.15188848156;74418;74441.62779186177;74904;75500.62249688717;77759;7563.584002879895;7922.564258965812;7922.960385198037;8166.714165004197;8227.71203007892;45656.77171614121;47292.03433639419;48276.27585586289;48850.75574622104;49526.75236623794;62147;66045.66977165084;66617.66691166707;67020.99468507878;69175.65412172907;10975.725606859893;11008.174386920853;11073;11204.887951120385;11459.937211302045;10999.560017599526;11089.564174330333;11240.325580465198;11254.493547790205;11651.242669226813;11498.712532186762;12200.81698774537;12358.376062024792;12369.196002259825;12464.875351246372;11831.70420739454;11925.224860384047;11985.460654270404;12401.565945191875;12467.189632673848;11664.825027624423;11903.880961190624;12218.144729868824;12323.383830808603;12371.566995155126;9038.186563209343;9223.76940576464;9419.61746834695;9734.123928846439;9921;8613.353998450017;8874.778130546789;8911.84146061008;9685.612575496902;9686.854697179408 22:40:45 INFO - PROCESS | 18357 | __end_tp_report 22:40:45 INFO - PROCESS | 18357 | __start_cc_report 22:40:45 INFO - PROCESS | 18357 | _x_x_mozilla_cycle_collect,295 22:40:45 INFO - PROCESS | 18357 | __end_cc_report 22:40:45 INFO - PROCESS | 18357 | __startTimestamp1479451245373__endTimestamp 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | ------- Summary: start ------- 22:40:45 INFO - PROCESS | 18357 | Number of tests: 6 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#0] dojo.html Cycles:165 Average:5469.31 Median:5683.69 stddev:622.29 (10.9%) stddev-sans-first:597.60 22:40:45 INFO - PROCESS | 18357 | Values: 3175.1 3179.3 3191.9 3223.6 3225.1 5448.2 5449.4 5481.5 5501.2 5550.0 5393.8 5447.3 5502.6 5521.0 5543.7 4970.6 4991.4 5016.4 5070.8 5128.7 4936.3 5039.2 5069.8 5075.3 5128.4 4881.9 4933.2 5036.7 5075.6 5085.0 4988.4 4995.2 4996.2 5002.3 5014.7 4931.5 4939.0 4943.5 4947.6 4951.6 5382.6 5421.3 5428.9 5438.7 5516.0 5910.6 5920.3 5934.4 5959.2 5962.2 5927.6 5950.6 5954.0 5957.4 5958.1 5372.2 5399.5 5468.2 5536.5 5537.7 5893.4 5938.6 5956.0 5966.9 5973.9 5791.8 5824.1 5824.2 5873.4 5936.7 5941.2 5951.6 5970.3 5970.6 5973.7 5769.7 5773.8 5807.3 5810.4 5872.2 5821.1 5849.2 5866.9 5927.8 5935.4 4472.4 4475.2 4503.4 4507.1 4534.8 3939.8 3973.6 4019.1 4034.0 4048.5 5623.9 5691.9 5698.3 5737.7 5751.0 5941.0 5978.3 5990.0 6002.5 6014.3 5441.5 5487.7 5670.9 5709.2 5709.2 5016.4 5045.5 5067.8 5095.4 5107.5 5967.6 5987.9 6043.5 6089.4 6117.5 5837.3 5850.1 5880.4 5887.5 5906.4 6010.2 6019.9 6032.4 6057.7 6062.3 5608.7 5626.2 5636.0 5727.5 5782.6 5900.7 5912.3 5951.3 5998.5 6045.6 5770.5 5803.7 5813.2 5821.5 5827.8 5613.9 5820.0 5821.4 5825.4 5834.9 5543.9 5580.5 5589.0 5617.6 5679.0 5740.4 5761.1 5768.4 5782.4 5826.4 5605.3 5632.6 5649.4 5657.5 5683.7 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#1] ext.html Cycles:180 Average:62148.28 Median:41040.69 stddev:131866.32 (321.3%) stddev-sans-first:132155.19 22:40:45 INFO - PROCESS | 18357 | Values: 567.6 580.1 588.9 595.6 602.8 40177.4 41459.6 41506.6 43631.3 43748.8 42252.8 42622.4 42721.6 43067.0 43292.4 8475.2 8579.4 8587.0 8613.1 8637.5 8531.9 8535.2 8600.1 8606.7 8617.3 8612.3 8616.8 8636.1 8686.6 8695.9 8528.5 8569.5 8620.3 8633.2 8647.4 8524.6 8582.4 8593.0 8595.8 8625.0 40613.6 40976.2 40993.6 41021.0 41060.4 3401.7 3449.4 3454.6 3458.5 3463.4 30100.2 30268.8 30711.4 31318.5 31847.2 4051.7 4117.8 4153.6 4154.7 4168.7 337654.0 339919.0 341047.0 342444.0 342475.0 55482.7 56428.9 56502.2 56542.0 56555.0 53990.5 54252.5 54486.2 54817.7 55132.2 17053.6 17160.9 17178.8 17220.3 17365.0 13292.6 13299.9 13317.3 13402.3 13428.8 17239.3 17747.0 17879.8 18092.6 18253.9 6859.4 6868.3 6927.9 7258.7 7386.3 853.9 855.6 987.2 1018.0 1085.6 31304.8 31378.5 31537.7 31612.2 31863.4 1097.5 1108.3 1114.6 1126.0 1142.9 15513.8 16289.2 16414.4 16422.8 16611.5 462638.0 679418.0 684665.0 689501.0 690610.0 54902.6 55009.0 55506.4 55650.7 55801.7 1331.6 1340.9 1360.6 1364.8 1376.7 29714.7 31407.8 31440.0 31452.0 31862.4 47501.5 48248.3 48313.3 48446.5 48669.3 438204.0 440023.0 442757.0 443154.0 446016.0 26959.0 27596.3 27660.6 27673.3 27707.2 45664.5 45861.8 46304.5 46880.5 47518.0 38995.0 39396.2 39505.1 39631.8 40911.4 39141.6 39155.6 39724.4 40078.2 40719.4 38094.2 38399.2 40080.4 41360.0 41374.0 30842.4 33151.2 34275.5 34357.5 34362.0 25944.0 26300.3 26467.0 26578.5 26882.2 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#2] jquery.html Cycles:180 Average:28190.84 Median:403.83 stddev:78335.31 (19398.2%) stddev-sans-first:78527.24 22:40:45 INFO - PROCESS | 18357 | Values: 382.0 398.1 402.9 404.8 416.0 16065.4 16228.7 17532.8 19173.3 19213.1 18234.5 18743.9 19269.7 19402.7 19571.5 4964.2 4989.4 5169.3 5188.9 5213.3 5076.8 5155.8 5156.7 5158.1 5168.4 5912.6 6176.1 6188.8 6308.7 6323.3 5610.2 5639.3 6283.2 6330.3 6334.2 5506.0 5511.9 5517.0 5524.9 5530.3 13405.4 13557.8 13704.0 13749.9 13799.1 2233.4 2279.8 2288.3 2321.3 2373.8 9851.3 9979.4 10005.0 10341.7 10422.7 1811.6 1852.4 1910.7 1927.3 1999.9 75635.0 77236.0 79595.6 90090.1 90178.5 10303.3 10556.2 10737.7 11154.6 11404.4 15741.2 15756.2 15792.7 15796.3 15802.2 7956.0 8091.2 8093.7 8204.3 8249.7 7731.4 7743.1 7760.3 7883.4 7951.2 4651.9 4696.1 4727.8 4777.2 4949.7 1773.0 1999.9 2001.6 2032.5 2064.2 882.1 914.3 953.7 965.8 1061.0 18934.3 19276.5 19302.4 19432.6 19788.5 929.7 944.2 982.2 993.9 1039.2 10096.0 10706.4 10790.1 10797.6 10835.3 454157.0 457255.0 483619.0 484382.0 489206.0 80576.0 81271.0 91473.5 97450.5 98348.5 1012.2 1028.4 1071.2 1089.4 1118.0 16987.2 17165.5 17362.0 17485.3 17502.3 42685.6 42757.4 43047.6 43258.4 45279.8 56750.4 57968.4 60820.0 61001.7 61812.0 7232.5 7552.2 8203.9 8210.4 8494.6 7348.8 11448.5 11974.8 12503.5 12910.8 11462.4 11612.8 11850.7 11905.9 12174.5 10855.3 10875.6 11050.2 11209.4 11642.6 10973.3 11338.3 11415.4 11931.7 11956.4 7753.7 7820.6 7895.2 7965.4 7990.2 9848.6 11498.5 12103.5 12199.3 12263.8 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#3] mootools.html Cycles:180 Average:5382.07 Median:5072.62 stddev:2980.64 (58.8%) stddev-sans-first:2974.23 22:40:45 INFO - PROCESS | 18357 | Values: 1432.9 1461.8 1569.7 1701.8 1713.1 7799.5 7981.6 8203.7 8271.6 8319.6 8267.2 8412.4 8423.3 8430.8 8441.7 2266.0 2293.6 2299.8 2300.7 2308.4 2218.5 2258.4 2263.7 2276.2 2295.6 2235.4 2246.5 2270.8 2276.9 2277.5 2233.8 2241.5 2266.1 2276.8 2283.8 2290.5 2296.0 2305.3 2313.3 2314.1 8017.5 8107.2 8195.8 8197.9 8248.3 4888.1 5057.2 5088.1 5101.6 5119.5 3101.9 3141.2 3373.5 3415.3 3418.7 1085.2 1090.0 1113.9 1127.4 1149.2 11277.3 11348.1 11461.1 11472.1 11472.9 4096.5 4318.4 4352.4 4447.8 4455.8 8871.6 8920.6 9010.5 9037.0 9065.2 4948.1 4969.5 4970.8 4985.6 5016.1 4584.1 4586.5 4698.9 4733.7 4781.0 3566.8 3684.4 3687.6 3732.8 3747.9 1106.9 1110.8 1120.7 1129.0 1131.8 896.1 916.2 919.3 934.5 942.7 5592.2 5736.2 5744.3 5763.4 5866.4 862.7 906.2 947.3 955.6 967.9 3647.2 3692.8 3700.6 3705.1 3717.9 9690.7 9957.0 9998.2 10036.9 10066.4 9923.1 9974.1 9990.6 10009.3 10017.6 7302.5 7465.5 7475.2 7582.6 7583.5 5389.6 5452.9 5489.8 5643.7 5664.6 9130.8 9312.0 9314.5 9315.4 9402.9 9164.7 9400.0 9469.0 9470.2 9513.2 6388.8 6565.3 6954.9 7129.0 7158.5 7676.9 7987.6 8036.7 8079.7 8087.3 6707.8 7125.9 7288.5 7352.6 7431.0 6642.6 6655.2 6738.4 6807.1 6902.2 6118.2 6180.1 6230.3 6232.5 6242.5 4866.2 4873.6 4924.5 4934.1 4955.5 4621.8 4631.4 4722.9 4780.7 4843.5 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#4] prototype.html Cycles:180 Average:4788.24 Median:5401.19 stddev:1396.16 (25.8%) stddev-sans-first:1359.28 22:40:45 INFO - PROCESS | 18357 | Values: 323.9 327.7 338.2 338.6 339.6 5348.4 5485.2 5542.4 5575.1 5621.5 5185.7 5362.3 5382.5 5397.6 5429.1 4255.3 4276.5 4290.7 4299.7 4311.9 4164.7 4244.6 4245.4 4277.2 4284.2 4209.6 4217.7 4219.2 4227.5 4236.3 4194.4 4203.7 4215.2 4222.1 4244.9 3693.5 3759.3 3768.6 3785.9 3793.4 5251.2 5265.0 5278.7 5290.5 5357.7 4833.4 4869.2 4878.0 4887.7 4928.0 5540.5 5637.0 5676.7 5684.3 5684.6 4107.8 4125.8 4131.4 4138.0 4160.6 5911.6 5925.8 5928.0 5938.7 5954.9 4148.3 4230.9 4251.5 4264.7 4268.2 4261.8 4262.5 4265.4 4268.5 4289.7 4825.8 4831.6 4836.0 4838.9 4841.7 5574.8 5641.9 5650.3 5661.7 5760.9 1433.3 1442.3 1443.7 1448.6 1451.3 975.7 1012.9 1015.7 1020.9 1029.7 5323.4 5364.4 5393.7 5399.0 5403.4 5671.4 5692.0 5702.7 5708.9 5729.0 5256.4 5341.9 5365.5 5536.3 5554.9 2992.7 3028.9 3034.5 3036.7 3041.5 5583.7 5869.3 5917.6 5920.3 5931.8 5722.3 5770.3 5776.9 5780.5 5784.5 5827.3 5828.5 5875.9 5889.5 5896.2 5552.9 5695.1 5714.6 5893.9 5925.2 5820.4 5832.3 5877.9 5883.1 5904.3 5760.0 6096.5 6141.8 6149.0 6165.7 4011.0 4111.9 4162.5 4236.5 4283.0 5851.6 5856.4 5858.7 5864.3 5915.7 5616.3 5715.0 5719.3 5723.5 5743.4 5665.9 5699.4 5701.9 5712.9 5717.9 5688.1 5691.1 5711.5 5715.6 5716.5 5504.7 5684.6 5706.3 5747.7 5762.0 5591.2 5605.5 5629.9 5647.9 5676.2 22:40:45 INFO - PROCESS | 18357 | 22:40:45 INFO - PROCESS | 18357 | [#5] yui.html Cycles:180 Average:17713.02 Median:31389.13 stddev:24554.71 (78.2%) stddev-sans-first:24590.43 22:40:45 INFO - PROCESS | 18357 | Values: 716.3 746.2 774.8 796.5 809.0 12961.0 13888.4 13897.7 13949.4 13950.9 12713.4 12863.5 12864.5 12876.1 12888.2 645.8 663.4 740.6 764.7 766.6 774.6 777.7 778.3 779.1 779.1 828.3 829.2 830.1 831.5 832.6 825.1 825.4 825.5 825.5 826.5 597.0 599.8 604.8 605.7 606.0 12379.8 12386.0 12403.4 12409.6 12443.6 13992.9 14322.6 14504.4 14592.3 14677.1 9676.3 9886.3 9933.8 9986.0 10019.2 3589.6 3612.9 3617.3 3765.4 3768.4 61488.4 63165.0 63202.0 63561.7 64866.4 10838.9 10860.5 10909.2 11073.9 11164.5 20074.4 20107.1 20138.1 20144.2 20219.6 6717.2 7149.7 7156.8 7264.7 7360.4 4196.5 4305.4 4389.2 4513.7 4553.6 3339.1 3415.9 3454.0 3456.5 3463.7 621.4 643.1 649.2 664.3 671.8 620.7 662.1 669.6 699.9 724.8 8659.9 9046.6 9054.7 9169.4 9371.8 621.6 631.3 672.7 700.5 703.0 3847.7 3898.5 3965.8 4045.4 4152.9 70579.6 89542.0 90730.0 92187.5 92375.0 77745.6 78314.0 78347.0 80079.6 84811.2 74418.0 74441.6 74904.0 75500.6 77759.0 7563.6 7922.6 7923.0 8166.7 8227.7 45656.8 47292.0 48276.3 48850.8 49526.8 62147.0 66045.7 66617.7 67021.0 69175.7 10975.7 11008.2 11073.0 11204.9 11459.9 10999.6 11089.6 11240.3 11254.5 11651.2 11498.7 12200.8 12358.4 12369.2 12464.9 11831.7 11925.2 11985.5 12401.6 12467.2 11664.8 11903.9 12218.1 12323.4 12371.6 9038.2 9223.8 9419.6 9734.1 9921.0 8613.4 8874.8 8911.8 9685.6 9686.9 22:40:45 INFO - PROCESS | 18357 | -------- Summary: end -------- 22:40:45 INFO - PROCESS | 18357 | 22:40:46 INFO - TEST-INFO | 18357: exit 0 22:40:46 INFO - TEST-OK | dromaeo_css | took 1116860ms 22:40:46 INFO - TEST-START | kraken 22:40:46 INFO - operating with platform_type : linux_ 22:40:46 INFO - Initialising browser for kraken test... 22:40:46 INFO - TEST-INFO | started process 18721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaximI/profile http://localhost:36993/getInfo.html) 22:40:50 INFO - PROCESS | 18721 | __metrics Screen width/height:1600/1200 22:40:50 INFO - PROCESS | 18721 | colorDepth:24 22:40:50 INFO - PROCESS | 18721 | Browser inner width/height: 1024/697 22:40:50 INFO - PROCESS | 18721 | __metrics 22:40:51 ERROR - PROCESS | 18721 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 22:40:52 INFO - TEST-INFO | 18721: exit 0 22:40:52 INFO - Browser initialized. 22:40:52 INFO - Running cycle 1/1 for kraken test... 22:40:52 INFO - TEST-INFO | started process 18849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaximI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:04 INFO - PROCESS | 18849 | RSS: Main: 186449920 22:41:04 INFO - PROCESS | 18849 | 22:41:07 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36993/tests/kraken/driver.html?testName=audio-beat-detection) 22:41:08 INFO - PROCESS | 18849 | RSS: Main: 199159808 22:41:08 INFO - PROCESS | 18849 | 22:41:11 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36993/tests/kraken/driver.html?testName=audio-dft) 22:41:11 INFO - PROCESS | 18849 | RSS: Main: 197521408 22:41:11 INFO - PROCESS | 18849 | 22:41:14 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36993/tests/kraken/driver.html?testName=audio-fft) 22:41:15 INFO - PROCESS | 18849 | RSS: Main: 193814528 22:41:15 INFO - PROCESS | 18849 | 22:41:17 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36993/tests/kraken/driver.html?testName=audio-oscillator) 22:41:18 INFO - PROCESS | 18849 | RSS: Main: 194338816 22:41:18 INFO - PROCESS | 18849 | 22:41:20 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:41:20 INFO - PROCESS | 18849 | RSS: Main: 194379776 22:41:20 INFO - PROCESS | 18849 | 22:41:23 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36993/tests/kraken/driver.html?testName=imaging-darkroom) 22:41:24 INFO - PROCESS | 18849 | RSS: Main: 199929856 22:41:24 INFO - PROCESS | 18849 | 22:41:27 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36993/tests/kraken/driver.html?testName=imaging-desaturate) 22:41:28 INFO - PROCESS | 18849 | RSS: Main: 196505600 22:41:28 INFO - PROCESS | 18849 | 22:41:31 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36993/tests/kraken/driver.html?testName=json-parse-financial) 22:41:32 INFO - PROCESS | 18849 | RSS: Main: 197206016 22:41:32 INFO - PROCESS | 18849 | 22:41:33 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:41:34 INFO - PROCESS | 18849 | RSS: Main: 197386240 22:41:34 INFO - PROCESS | 18849 | 22:41:36 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:41:36 INFO - PROCESS | 18849 | RSS: Main: 197308416 22:41:36 INFO - PROCESS | 18849 | 22:41:38 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:41:39 INFO - PROCESS | 18849 | RSS: Main: 197615616 22:41:39 INFO - PROCESS | 18849 | 22:41:42 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:41:42 INFO - PROCESS | 18849 | RSS: Main: 197492736 22:41:42 INFO - PROCESS | 18849 | 22:41:45 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:41:46 INFO - PROCESS | 18849 | RSS: Main: 197423104 22:41:46 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | Cycle 1(1): loaded http://localhost:36993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36993/tests/kraken/driver.html?testName=ai-astar) 22:41:48 INFO - PROCESS | 18849 | RSS: Main: 198860800 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | __start_tp_report 22:41:48 INFO - PROCESS | 18849 | _x_x_mozilla_page_load 22:41:48 INFO - PROCESS | 18849 | _x_x_mozilla_page_load_details 22:41:48 INFO - PROCESS | 18849 | |i|pagename|runs| 22:41:48 INFO - PROCESS | 18849 | |0;ai-astar;105;112;112;113;115;113;113;114;113;113 22:41:48 INFO - PROCESS | 18849 | |1;audio-beat-detection;156;125;126;170;126;126;128;131;158;126 22:41:48 INFO - PROCESS | 18849 | |2;audio-dft;163;169;163;167;172;166;163;162;164;162 22:41:48 INFO - PROCESS | 18849 | |3;audio-fft;76;76;76;116;76;76;76;78;112;77 22:41:48 INFO - PROCESS | 18849 | |4;audio-oscillator;82;83;114;83;83;83;98;83;84;114 22:41:48 INFO - PROCESS | 18849 | |5;imaging-gaussian-blur;119;120;118;119;117;119;119;122;119;117 22:41:48 INFO - PROCESS | 18849 | |6;imaging-darkroom;146;148;147;146;148;147;147;148;148;151 22:41:48 INFO - PROCESS | 18849 | |7;imaging-desaturate;97;97;97;97;97;96;97;97;97;95 22:41:48 INFO - PROCESS | 18849 | |8;json-parse-financial;54;54;57;55;54;55;56;55;60;55 22:41:48 INFO - PROCESS | 18849 | |9;json-stringify-tinderbox;64;63;64;62;63;62;63;63;64;65 22:41:48 INFO - PROCESS | 18849 | |10;stanford-crypto-aes;83;83;82;83;88;82;83;83;84;84 22:41:48 INFO - PROCESS | 18849 | |11;stanford-crypto-ccm;143;141;137;132;137;144;140;140;181;133 22:41:48 INFO - PROCESS | 18849 | |12;stanford-crypto-pbkdf2;173;169;177;171;172;167;168;177;167;168 22:41:48 INFO - PROCESS | 18849 | |13;stanford-crypto-sha256-iterative;65;66;70;68;67;71;65;64;65;63 22:41:48 INFO - PROCESS | 18849 | __end_tp_report 22:41:48 INFO - PROCESS | 18849 | __start_cc_report 22:41:48 INFO - PROCESS | 18849 | _x_x_mozilla_cycle_collect,845 22:41:48 INFO - PROCESS | 18849 | __end_cc_report 22:41:48 INFO - PROCESS | 18849 | __startTimestamp1479451308393__endTimestamp 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | ------- Summary: start ------- 22:41:48 INFO - PROCESS | 18849 | Number of tests: 14 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 22:41:48 INFO - PROCESS | 18849 | Values: 105.0 112.0 112.0 113.0 115.0 113.0 113.0 114.0 113.0 113.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:129.50 stddev:17.11 (13.2%) stddev-sans-first:16.74 22:41:48 INFO - PROCESS | 18849 | Values: 156.0 125.0 126.0 170.0 126.0 126.0 128.0 131.0 158.0 126.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.35 (2.0%) stddev-sans-first:3.46 22:41:48 INFO - PROCESS | 18849 | Values: 163.0 169.0 163.0 167.0 172.0 166.0 163.0 162.0 164.0 162.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:15.91 (20.9%) stddev-sans-first:16.61 22:41:48 INFO - PROCESS | 18849 | Values: 76.0 76.0 76.0 116.0 76.0 76.0 76.0 78.0 112.0 77.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:13.15 (15.8%) stddev-sans-first:13.56 22:41:48 INFO - PROCESS | 18849 | Values: 82.0 83.0 114.0 83.0 83.0 83.0 98.0 83.0 84.0 114.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:1.45 (1.2%) stddev-sans-first:1.54 22:41:48 INFO - PROCESS | 18849 | Values: 119.0 120.0 118.0 119.0 117.0 119.0 119.0 122.0 119.0 117.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.39 22:41:48 INFO - PROCESS | 18849 | Values: 146.0 148.0 147.0 146.0 148.0 147.0 147.0 148.0 148.0 151.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:41:48 INFO - PROCESS | 18849 | Values: 97.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 95.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.84 (3.3%) stddev-sans-first:1.87 22:41:48 INFO - PROCESS | 18849 | Values: 54.0 54.0 57.0 55.0 54.0 55.0 56.0 55.0 60.0 55.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 22:41:48 INFO - PROCESS | 18849 | Values: 64.0 63.0 64.0 62.0 63.0 62.0 63.0 63.0 64.0 65.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:1.72 (2.1%) stddev-sans-first:1.81 22:41:48 INFO - PROCESS | 18849 | Values: 83.0 83.0 82.0 83.0 88.0 82.0 83.0 83.0 84.0 84.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:140.50 stddev:13.98 (10.0%) stddev-sans-first:14.83 22:41:48 INFO - PROCESS | 18849 | Values: 143.0 141.0 137.0 132.0 137.0 144.0 140.0 140.0 181.0 133.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.50 stddev:3.81 (2.2%) stddev-sans-first:3.97 22:41:48 INFO - PROCESS | 18849 | Values: 173.0 169.0 177.0 171.0 172.0 167.0 168.0 177.0 167.0 168.0 22:41:48 INFO - PROCESS | 18849 | 22:41:48 INFO - PROCESS | 18849 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:2.59 (3.9%) stddev-sans-first:2.70 22:41:48 INFO - PROCESS | 18849 | Values: 65.0 66.0 70.0 68.0 67.0 71.0 65.0 64.0 65.0 63.0 22:41:48 INFO - PROCESS | 18849 | -------- Summary: end -------- 22:41:48 INFO - PROCESS | 18849 | 22:41:49 INFO - TEST-INFO | 18849: exit 0 22:41:49 INFO - TEST-OK | kraken | took 63201ms 22:41:49 INFO - SUITE-END | took 1180s 22:41:50 INFO - Completed test suite (00:19:40) 22:41:50 INFO - javascript benchmark 22:41:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7043.915095277537, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.079227024163, 3179.332340208555, 3191.904242872713, 3223.5809344785175, 3225.1292151119196, 5448.155535891943, 5449.427810079944, 5481.479259470354, 5501.229827824108, 5550.0, 5393.81121660741, 5447.264619276397, 5502.614816962814, 5521.0, 5543.695096769686, 4970.627202959774, 4991.351124353829, 5016.448190699039, 5070.822521211759, 5128.71792051437, 4936.33359496467, 5039.21892106724, 5069.847904562869, 5075.289459475676, 5128.358955130609, 4881.926771098437, 4933.161362568372, 5036.748162591855, 5075.6447048706605, 5085.033843569729, 4988.376452943382, 4995.150824359867, 4996.150654388763, 5002.299678045077, 5014.749262536859, 4931.482194369575, 4938.975305123451, 4943.4809345018975, 4947.579455746266, 4951.62862785289, 5382.6232163748555, 5421.349438067417, 5428.945710542884, 5438.700871452069, 5516.0, 5910.615809972381, 5920.319163296233, 5934.37689042653, 5959.22530071088, 5962.224910761616, 5927.555433342473, 5950.642961422329, 5953.970230148865, 5957.374475680034, 5958.076498142751, 5372.194170874322, 5399.487048730364, 5468.152436372368, 5536.501714845643, 5537.723113844291, 5893.410658934073, 5938.584299099108, 5956.047032474783, 5966.850828729316, 5973.940260597426, 5791.797287095016, 5824.068149096124, 5824.184614154022, 5873.383294754075, 5936.703164841827, 5941.168236446901, 5951.642901425928, 5970.34326224115, 5970.611910225822, 5973.731182096729, 5769.740361683735, 5773.769049237983, 5807.303123625192, 5810.448007439287, 5872.207252021008, 5821.126830975303, 5849.181114643953, 5866.882662346729, 5927.792527261611, 5935.436133567304, 4472.44094488189, 4475.194464996332, 4503.369528266046, 4507.076049409863, 4534.752942940718, 3939.783311917872, 3973.6225058619384, 4019.1157945252, 4033.9596604033586, 4048.5344185419053, 5623.887522249532, 5691.9146212806845, 5698.344690360579, 5737.684427356536, 5750.993576124161, 5941.0, 5978.28260608721, 5990.011648078105, 6002.549808764273, 6014.338422773491, 5441.5102640762525, 5487.670739755547, 5670.943290567042, 5709.200711900337, 5709.200711900337, 5016.44819069902, 5045.495450454999, 5067.847964561069, 5095.363079615048, 5107.463716309809, 5967.582269241198, 5987.910181347196, 6043.54673399488, 6089.391060893875, 6117.541184411098, 5837.29952405714, 5850.0932355484965, 5880.441358070976, 5887.470127688529, 5906.40935906406, 6010.2186715726675, 6019.939800601938, 6032.366601506778, 6057.697115144137, 6062.302835174011, 5608.747606357642, 5626.24045753818, 5635.971820140873, 5727.4845263926445, 5782.5663075268685, 5900.675462849413, 5912.290525137011, 5951.315598706205, 5998.490128338965, 6045.637261764308, 5770.451807078321, 5803.65178089316, 5813.15709222152, 5821.505172060253, 5827.825165245049, 5613.943860561505, 5820.0, 5821.417858214314, 5825.3883342248455, 5834.854128646818, 5543.944560554342, 5580.525655319343, 5588.972055139699, 5617.578681598815, 5678.971605142113, 5740.39725828782, 5761.107028410603, 5768.365479797135, 5782.3639399666845, 5826.388229235869, 5605.299337582802, 5632.633878797865, 5649.4350564944825, 5657.547396208376, 5683.687397193194], "value": 5427.245410360707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.5573053018645, 580.09794769134, 588.9204957330759, 595.5741644724025, 602.8131279303416, 40177.397339039904, 41459.585404145946, 41506.58493415065, 43631.34552981708, 43748.78125609375, 42252.788736056275, 42622.36066459006, 42721.572784272146, 43067.0, 43292.350614740804, 8475.237228649436, 8579.442336248156, 8587.0, 8613.138686131368, 8637.481751094923, 8531.872021919677, 8535.231829135377, 8600.096989816073, 8606.741797746077, 8617.310615150773, 8612.311015118807, 8616.827663446727, 8636.093210212932, 8686.609102590399, 8695.91301087364, 8528.530930798803, 8569.528675922822, 8620.267277281408, 8633.223009929137, 8647.394682372236, 8524.573771311472, 8582.356323275779, 8593.0, 8595.785105372353, 8624.956875215647, 40613.59386406127, 40976.180476390604, 40993.59006409928, 41021.0, 41060.38409423861, 3401.744869134825, 3449.3963556377535, 3454.5681789776277, 3458.515807786912, 3463.3592785334795, 30100.24749381261, 30268.8486557568, 30711.38577228465, 31318.530222046687, 31847.203819904455, 4051.7117215553226, 4117.75293482392, 4153.626173644387, 4154.709170358076, 4168.6665066794585, 337654.0, 339919.0, 341047.0, 342444.0, 342475.0, 55482.72258638681, 56428.946381702284, 56502.152467713015, 56542.0, 56555.0, 53990.46009539933, 54252.45747542553, 54486.182707259424, 54817.72591137099, 55132.17301740477, 17053.57366065858, 17160.914195428944, 17178.82191794522, 17220.31118755261, 17365.0, 13292.601221963356, 13299.93350033263, 13317.267550284634, 13402.26287554194, 13428.798568021488, 17239.310427582757, 17747.0, 17879.821201788076, 18092.638147236983, 18253.908730456264, 6859.416949559243, 6868.313168683192, 6927.861442771217, 7258.709651613982, 7386.2613738625705, 853.8633818588996, 855.6106971328031, 987.1559816356911, 1017.9643712470177, 1085.6146068145852, 31304.84347578293, 31378.52932206019, 31537.684623153935, 31612.209694757814, 31863.362732745678, 1097.4677281518457, 1108.3017698849835, 1114.570890207276, 1126.0259875207887, 1142.8857114288505, 15513.84486155124, 16289.185540722916, 16414.425495107615, 16422.75365869513, 16611.50165495037, 462638.0, 679418.0, 684665.0, 689501.0, 690610.0, 54902.62743431366, 55009.0, 55506.44493555013, 55650.721746391006, 55801.72099139478, 1331.5872079655337, 1340.8525062243145, 1360.5850215684113, 1364.8293963254594, 1376.7108907129616, 29714.70285297206, 31407.84296078505, 31440.0, 31452.0, 31862.362752745277, 47501.52498475109, 48248.27627585519, 48313.27530086981, 48446.5155348442, 48669.2699609499, 438204.0, 440023.0, 442757.0, 443154.0, 446016.0, 26959.0, 27596.310092247855, 27660.58509122405, 27673.308167295978, 27707.168784936483, 45664.54335456603, 45861.77069114633, 46304.53695463002, 46880.53119468762, 47518.0, 38995.0, 39396.2120757589, 39505.14845546382, 39631.80184099061, 40911.38632920449, 39141.608583913796, 39155.60844391634, 39724.404133938595, 40078.1984360317, 40719.38920916248, 38094.23811523809, 38399.232015360096, 40080.3987940187, 41360.0, 41374.0, 30842.38315233638, 33151.17122071871, 34275.4858677125, 34357.484637729955, 34362.0, 25944.0, 26300.342491437867, 26467.0, 26578.46843063089, 26882.193534194004], "value": 19610.913475198002, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.95607505136917, 398.07844839197276, 402.87510871629786, 404.7814180342615, 415.9787721144588, 16065.437709680164, 16228.675426491463, 17532.82467175328, 19173.328933487348, 19213.135408906615, 18234.45296641103, 18743.90628046861, 19269.710954335696, 19402.70895936562, 19571.5107122322, 4964.156093464111, 4989.3513843200335, 5169.3279873616375, 5188.948110518903, 5213.296205012312, 5076.796928122871, 5155.81954631588, 5156.690598564098, 5158.071547121516, 5168.3539557555305, 5912.615679980809, 6176.135341052256, 6188.752449901998, 6308.747650093991, 6323.336049714782, 5610.214569960209, 5639.2668953036255, 6283.246010478726, 6330.303666596671, 6334.208223972027, 5505.981393442186, 5511.862203444906, 5517.0, 5524.889502209933, 5530.2810634617645, 13405.396757145854, 13557.796633050511, 13704.0, 13749.900007999337, 13799.103058301178, 2233.4081468410886, 2279.8290128240283, 2288.3478208710603, 2321.292005938188, 2373.753779265882, 9851.262332707372, 9979.351342162809, 10004.99950005001, 10341.689749307458, 10422.687319380431, 1811.6286161336893, 1852.3794528832857, 1910.74204982327, 1927.267638297452, 1999.8800071995581, 75635.0, 77236.0, 79595.60202198951, 90090.09909900883, 90178.54910725405, 10303.278770486144, 10556.208284378548, 10737.731556710989, 11154.609588664358, 11404.429778511207, 15741.22210669454, 15756.212189390484, 15792.68414631701, 15796.289166987513, 15802.209889505479, 7956.0, 8091.1504292048485, 8093.716719914893, 8204.302634276153, 8249.670013199404, 7731.420143489261, 7743.148253692089, 7760.262775036363, 7883.448158628841, 7951.165127661628, 4651.906961860744, 4696.131215725101, 4727.834525791581, 4777.235642297285, 4949.727764972961, 1772.9556761081076, 1999.8700084494462, 2001.599680063993, 2032.4756432675492, 2064.246550009266, 882.1311008656468, 914.3051281026335, 953.7472569769017, 965.7782904625655, 1060.9734756630992, 18934.337298194772, 19276.518087047934, 19302.42092737192, 19432.611347772967, 19788.505287367643, 929.7396728915915, 944.15498129174, 982.2436723722693, 993.9204863611038, 1039.2205845615788, 10096.0, 10706.357618542912, 10790.08284295828, 10797.622083227207, 10835.349879007284, 454157.0, 457255.0, 483619.0, 484382.0, 489206.0, 80576.0, 81271.0, 91473.54263228641, 97450.51274743582, 98348.50825745969, 1012.2307046644456, 1028.3932479836783, 1071.2019545438698, 1089.4171618184391, 1117.9664610061711, 16987.235574398936, 17165.458925225452, 17362.0, 17485.300587976337, 17502.299908003537, 42685.5731442694, 42757.35863962105, 43047.56952430561, 43258.35112473378, 45279.77360113178, 56750.43249567451, 57968.420315796306, 60820.0, 61001.69499152476, 61812.0, 7232.493725439169, 7552.207018263223, 8203.892474515864, 8210.425270231026, 8494.617742201492, 7348.779536613696, 11448.484818183035, 11974.820377694168, 12503.499860005499, 12910.806337905127, 11462.426878655868, 11612.767744645229, 11850.703732406759, 11905.940470297593, 12174.539055313066, 10855.348679079281, 10875.619353322596, 11050.226484146033, 11209.383483908463, 11642.592509262135, 10973.341599504056, 11338.263012904135, 11415.429228538706, 11931.701707457383, 11956.402179891145, 7753.689852406066, 7820.64807083694, 7895.249951254622, 7965.362770978192, 7990.240927111915, 9848.60605575769, 11498.48256828428, 12103.455344509342, 12199.329036903055, 12263.75472490563], "value": 8942.452074769499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.8996970212083, 1461.7880407340936, 1569.7017566662341, 1701.7532457793627, 1713.100622173359, 7799.454038217327, 7981.600919953994, 8203.712870049549, 8271.586420678965, 8319.625616847241, 8267.17328267173, 8412.369072319585, 8423.284020858218, 8430.83138337233, 8441.746747597583, 2265.954680906381, 2293.6100862853355, 2299.8045166160814, 2300.735415427222, 2308.4228942764307, 2218.456478162844, 2258.3789457899043, 2263.660450932365, 2276.169198242646, 2295.5753185660624, 2235.3740952533317, 2246.472079061419, 2270.7729227077325, 2276.931692049241, 2277.4534111813127, 2233.8436309458343, 2241.450844543081, 2266.0935625749667, 2276.829237807171, 2283.7602051784575, 2290.5075408787193, 2296.0471404367167, 2305.2738387407912, 2313.306008197551, 2314.132200424841, 8017.478863873829, 8107.22981316774, 8195.754127376189, 8197.877031844528, 8248.298894593907, 4888.095702295087, 5057.190849464105, 5088.058709138784, 5101.642884998052, 5119.488051194888, 3101.9379612407624, 3141.2461009357817, 3373.4771110477914, 3415.3169366126626, 3418.67522585354, 1085.234909388879, 1089.983650245239, 1113.9387333696643, 1127.4250132432437, 1149.2472430557998, 11277.32336059839, 11348.09215262777, 11461.083113350913, 11472.139589530818, 11472.885271147348, 4096.508418989741, 4318.395424640553, 4352.412424322676, 4447.844325448594, 4455.844045458393, 8871.64513419456, 8920.598573064228, 9010.504422256708, 9036.954815226014, 9065.184133428023, 4948.084604348207, 4969.527894849984, 4970.801167953241, 4985.626078044161, 5016.147254966664, 4584.083183363341, 4586.518415566385, 4698.859034228979, 4733.668643194943, 4780.95219047805, 3566.8038257895546, 3684.3552378333684, 3687.575928768172, 3732.7760334380023, 3747.8500859965843, 1106.9335839849634, 1110.838928355384, 1120.6862078618, 1129.0346753525782, 1131.8245671920865, 896.0994200828126, 916.1800188830958, 919.2921450483224, 934.5467448287575, 942.7313215733483, 5592.161175823578, 5736.1682556029145, 5744.310682718017, 5763.366029736726, 5866.384029676908, 862.65062649627, 906.1708536688856, 947.303731757158, 955.6225291010012, 967.9322447428613, 3647.1793846384353, 3692.7968961707365, 3700.629937006278, 3705.1292946157632, 3717.8698745544316, 9690.70927872165, 9957.0, 9998.200143988464, 10036.949815250877, 10066.396016239049, 9923.057309555581, 9974.102330790118, 9990.600375985025, 10009.349392289623, 10017.649382271586, 7302.48882578225, 7465.477416580896, 7475.2151024141685, 7582.62086895653, 7583.469157158946, 5389.649672771257, 5452.890942181213, 5489.780408783604, 5643.746031428677, 5664.603477756517, 9130.817383652156, 9311.953440232755, 9314.534273286445, 9315.441073535609, 9402.858957115786, 9164.725058248263, 9400.0, 9468.95265523668, 9470.19503342196, 9513.23894088485, 6388.840278993062, 6565.310642382672, 6954.860902781815, 7129.0, 7158.46311526648, 7676.923230767844, 7987.600619969095, 8036.718714845187, 8079.717209897625, 8087.272145506932, 6707.765228216989, 7125.857482850418, 7288.453365997678, 7352.632368381453, 7431.033965584439, 6642.568233064835, 6655.23464801554, 6738.35985581369, 6807.149106361705, 6902.206246281541, 6118.235220597426, 6180.103884936749, 6230.252369715663, 6232.470240029648, 6242.469390101892, 4866.221404575251, 4873.634477414279, 4924.482929292372, 4934.111859865116, 4955.479674634255, 4621.838235661736, 4631.374764406762, 4722.881927951828, 4780.737059461763, 4843.539863712942], "value": 4359.526668611015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.90768630940187, 327.6575978102882, 338.1883479648841, 338.5615627762049, 339.58231375408246, 5348.358197016354, 5485.204645326426, 5542.39033706292, 5575.10798272276, 5621.4940655341015, 5185.677652198693, 5362.27609272748, 5382.501374106832, 5397.595180361469, 5429.131338985753, 4255.340422234543, 4276.465441819772, 4290.69965102443, 4299.742015479082, 4311.935320970188, 4164.66682665386, 4244.596763307481, 4245.429191199245, 4277.1873344064525, 4284.164587905359, 4209.557996410379, 4217.722429887857, 4219.164663371428, 4227.450431443908, 4236.284304856523, 4194.370844373338, 4203.747775133471, 4215.18525734211, 4222.113356195203, 4244.851430199959, 3693.519842420468, 3759.2895232669343, 3768.5854555998817, 3785.9432108518395, 3793.430985352192, 5251.159814429711, 5264.973675131638, 5278.736063196825, 5290.523852853262, 5357.705326207057, 4833.404976357829, 4869.247071054418, 4877.975625118694, 4887.657863949525, 4927.975360123212, 5540.48179406076, 5636.985342638323, 5676.722737384055, 5684.289463817023, 5684.602077854552, 4107.774072426016, 4125.752454852688, 4131.421600975866, 4138.02756352257, 4160.583941605845, 5911.615744976562, 5925.762969481216, 5928.0, 5938.732757025944, 5954.910676339859, 4148.282874717065, 4230.915381692349, 4251.489821221473, 4264.744115353089, 4268.189044081614, 4261.786910654455, 4262.509811371732, 4265.445492086009, 4268.466441694788, 4289.742615443083, 4825.806967721252, 4831.613470922318, 4835.95164048362, 4838.879028024257, 4841.709497430165, 5574.832755017356, 5641.915371269434, 5650.3219613646625, 5661.660300381908, 5760.94239057604, 1433.31917339263, 1442.343733601209, 1443.7256921184942, 1448.630599197198, 1451.2743628185908, 975.658519518163, 1012.9139023182964, 1015.6597539824094, 1020.897910208988, 1029.6807989523122, 5323.414424413311, 5364.383095943938, 5393.6763794172475, 5399.0, 5403.378611459732, 5671.376148623648, 5692.0, 5702.714864256771, 5708.942910570924, 5729.0, 5256.369235691742, 5341.893162136736, 5365.54392876602, 5536.307961504812, 5554.86112847174, 2992.713133352636, 3028.8939887103847, 3034.484137696597, 3036.6963303669454, 3041.5133578627315, 5583.715745378505, 5869.325027621793, 5917.644941303535, 5920.2895652521975, 5931.762729490858, 5722.284714410699, 5770.307563092456, 5776.855578610484, 5780.479756821906, 5784.500377271775, 5827.329857066492, 5828.5337173026055, 5875.882482350415, 5889.499392551681, 5896.233489646233, 5552.861178470571, 5695.067040474242, 5714.628549144292, 5893.941060589339, 5925.200097986889, 5820.447057529528, 5832.337783731616, 5877.882442351214, 5883.146943693055, 5904.3210030845285, 5759.971200143972, 6096.542759292982, 6141.7543298267565, 6149.0, 6165.660888651168, 4010.9972506873282, 4111.938320925129, 4162.4796900387455, 4236.491621005376, 4282.978585107055, 5851.590388672752, 5856.3558008618165, 5858.736356864037, 5864.266966629171, 5915.733791979457, 5616.326040875121, 5714.971305165111, 5719.256496655408, 5723.484886360247, 5743.368229494836, 5665.943340566541, 5699.401562836008, 5701.885962280814, 5712.857178570569, 5717.914231286451, 5688.11834165705, 5691.117876729114, 5711.457411545896, 5715.628484148683, 5716.5426765859465, 5504.688031027058, 5684.573656975661, 5706.258186435737, 5747.712614369349, 5762.0, 5591.245181900392, 5605.5235304997905, 5629.943700562942, 5647.943520564741, 5676.20533125371], "value": 4342.735644378626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3409663109938, 746.2127455534412, 774.7846437285266, 796.4703472190994, 808.9555074470902, 12961.027922905785, 13888.37502312396, 13897.652558686037, 13949.442022319108, 13950.930245348773, 12713.427895744691, 12863.485460581589, 12864.485420583165, 12876.098673092887, 12888.226706397623, 645.844997200672, 663.3863676099612, 740.555666600041, 764.663548038864, 766.643510767493, 774.5778550689887, 777.6617171530374, 778.3189709004621, 779.0573406178531, 779.104030365079, 828.2835347424494, 829.241244261503, 830.0910502999207, 831.4512421801612, 832.5587438657521, 825.1006403020676, 825.405707890318, 825.475822852487, 825.5335735309561, 826.4586695714316, 596.9940300596982, 599.7930713903696, 604.8457643300974, 605.7486143250545, 606.0364021206259, 12379.75240495194, 12386.0, 12403.379831008504, 12409.62771116868, 12443.564475243413, 13992.851608388133, 14322.57032289033, 14504.41982320706, 14592.343344549521, 14677.119372837557, 9676.274279429072, 9886.258530610234, 9933.75165620858, 9985.950070249603, 10019.198464122852, 3589.569251689788, 3612.8554857805657, 3617.2584620152807, 3765.4163604641326, 3768.434734789776, 61488.38511614871, 63165.0, 63202.0, 63561.68219158921, 64866.3513364865, 10838.891611083945, 10860.511276992554, 10909.23635345534, 11073.944630276797, 11164.497597607964, 20074.39776806698, 20107.095180716904, 20138.093785779383, 20144.194232230548, 20219.595608087755, 6717.193936727526, 7149.7497587584185, 7156.821079473055, 7264.673089710976, 7360.447966402541, 4196.538380778112, 4305.418768466279, 4389.18800021997, 4513.661475389359, 4553.590176884097, 3339.0984434203115, 3415.9487607685905, 3453.9827300863335, 3456.4815277708044, 3463.6709512596262, 621.3998952696734, 643.1092936283281, 649.2403887451693, 664.259350823828, 671.8387586979187, 620.7051650466083, 662.0929326822285, 669.5982410553629, 699.9300069993062, 724.8296650287178, 8659.870101948476, 9046.638134474548, 9054.728358149267, 9169.358144929924, 9371.765705857408, 621.586644881158, 631.251966419794, 672.7275453441364, 700.5201437015661, 702.9683664235122, 3847.74989625679, 3898.4542164097047, 3965.7620542767527, 4045.3527435610163, 4152.854650087293, 70579.6471017652, 89542.0, 90730.0, 92187.53906230426, 92375.04596638755, 77745.61127194327, 78314.0, 78347.0, 80079.59960200278, 84811.15188848156, 74418.0, 74441.62779186177, 74904.0, 75500.62249688717, 77759.0, 7563.584002879895, 7922.564258965812, 7922.960385198037, 8166.714165004197, 8227.71203007892, 45656.77171614121, 47292.03433639419, 48276.27585586289, 48850.75574622104, 49526.75236623794, 62147.0, 66045.66977165084, 66617.66691166707, 67020.99468507878, 69175.65412172907, 10975.725606859893, 11008.174386920853, 11073.0, 11204.887951120385, 11459.937211302045, 10999.560017599526, 11089.564174330333, 11240.325580465198, 11254.493547790205, 11651.242669226813, 11498.712532186762, 12200.81698774537, 12358.376062024792, 12369.196002259825, 12464.875351246372, 11831.70420739454, 11925.224860384047, 11985.460654270404, 12401.565945191875, 12467.189632673848, 11664.825027624423, 11903.880961190624, 12218.144729868824, 12323.383830808603, 12371.566995155126, 9038.186563209343, 9223.76940576464, 9419.61746834695, 9734.123928846439, 9921.0, 8613.353998450017, 8874.778130546789, 8911.84146061008, 9685.612575496902, 9686.854697179408], "value": 6778.031006824521, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 126.0, 170.0, 126.0, 126.0, 128.0, 131.0, 158.0, 126.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 163.0, 167.0, 172.0, 166.0, 163.0, 162.0, 164.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 116.0, 76.0, 76.0, 76.0, 78.0, 112.0, 77.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 83.0, 83.0, 83.0, 98.0, 83.0, 84.0, 114.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 118.0, 119.0, 117.0, 119.0, 119.0, 122.0, 119.0, 117.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 151.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 95.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 57.0, 55.0, 54.0, 55.0, 56.0, 55.0, 60.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 63.0, 64.0, 65.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 88.0, 82.0, 83.0, 83.0, 84.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 137.0, 132.0, 137.0, 144.0, 140.0, 140.0, 181.0, 133.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 177.0, 171.0, 172.0, 167.0, 168.0, 177.0, 167.0, 168.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 70.0, 68.0, 67.0, 71.0, 65.0, 64.0, 65.0, 63.0], "value": 66.4, "unit": "score"}]}]} 22:41:50 INFO - Return code: 0 22:41:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:41:50 ERROR - # TBPL SUCCESS # 22:41:50 INFO - Running post-action listener: _resource_record_post_action 22:41:50 INFO - [mozharness: 2016-11-18 06:41:50.183693Z] Finished run-tests step (success) 22:41:50 INFO - Running post-run listener: _resource_record_post_run 22:41:50 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392241152; Read time: 20; Write time: 306096 22:41:50 INFO - TinderboxPrint: CPU usage
13.4% 22:41:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 22:41:50 INFO - TinderboxPrint: I/O write bytes / time
392,241,152 / 306,096 22:41:50 INFO - TinderboxPrint: CPU idle
8,267.1 (86.5%) 22:41:50 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 22:41:50 INFO - TinderboxPrint: Swap in / out
0 / 0 22:41:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103755776; Read time: 0; Write time: 84780 22:41:50 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288485376; Read time: 20; Write time: 221316 22:41:50 INFO - Running post-run listener: _upload_blobber_files 22:41:50 INFO - Blob upload gear active. 22:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:41:50 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 22:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:41:52 INFO - (blobuploader) - INFO - Done attempting. 22:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:41:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:41:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:41:55 INFO - (blobuploader) - INFO - Done attempting. 22:41:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:41:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:41:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:41:56 INFO - (blobuploader) - INFO - Done attempting. 22:41:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:41:56 INFO - Return code: 0 22:41:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:41:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:41:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f72d20c7d46d6537a7e825ad3b7e2bdd40e5de3ea9fb6ead1c536f2300c713414c01ddafde5988bbd5723962a547193ce6699b0d82993339523cf3761d51a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4d76e346e672502d63fc6053997fb60e0dec2ebf478bdba454a8945459e921a34028aac133e881454f912e6ace29797945d0a041179ff0b7ca26ab76608d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d710bd84943e5cbe752d0c306abb1bd1d3a1c8728b8fd89b160f6d9a25357b9b09e0a34cffa5bb6bf256203dfa8b48b307c533f339397a3c09bb0e431a4ffe3"} 22:41:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:41:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:41:56 INFO - Contents: 22:41:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f72d20c7d46d6537a7e825ad3b7e2bdd40e5de3ea9fb6ead1c536f2300c713414c01ddafde5988bbd5723962a547193ce6699b0d82993339523cf3761d51a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4d76e346e672502d63fc6053997fb60e0dec2ebf478bdba454a8945459e921a34028aac133e881454f912e6ace29797945d0a041179ff0b7ca26ab76608d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d710bd84943e5cbe752d0c306abb1bd1d3a1c8728b8fd89b160f6d9a25357b9b09e0a34cffa5bb6bf256203dfa8b48b307c533f339397a3c09bb0e431a4ffe3"} 22:41:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:41:56 INFO - Copying logs to upload dir... 22:41:56 INFO - mkdir: /builds/slave/test/build/upload/logs 22:41:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.974703 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-17 22:41:56.454459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:41:56.463022) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f72d20c7d46d6537a7e825ad3b7e2bdd40e5de3ea9fb6ead1c536f2300c713414c01ddafde5988bbd5723962a547193ce6699b0d82993339523cf3761d51a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4d76e346e672502d63fc6053997fb60e0dec2ebf478bdba454a8945459e921a34028aac133e881454f912e6ace29797945d0a041179ff0b7ca26ab76608d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d710bd84943e5cbe752d0c306abb1bd1d3a1c8728b8fd89b160f6d9a25357b9b09e0a34cffa5bb6bf256203dfa8b48b307c533f339397a3c09bb0e431a4ffe3"} build_url:https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/YpmHD6FRT6-AM_DFIJ7Y5w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f72d20c7d46d6537a7e825ad3b7e2bdd40e5de3ea9fb6ead1c536f2300c713414c01ddafde5988bbd5723962a547193ce6699b0d82993339523cf3761d51a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff4d76e346e672502d63fc6053997fb60e0dec2ebf478bdba454a8945459e921a34028aac133e881454f912e6ace29797945d0a041179ff0b7ca26ab76608d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d710bd84943e5cbe752d0c306abb1bd1d3a1c8728b8fd89b160f6d9a25357b9b09e0a34cffa5bb6bf256203dfa8b48b307c533f339397a3c09bb0e431a4ffe3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:41:56.487998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:41:56.488320) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1479448302.160384-184221996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004236 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:41:56.575170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:41:56.575471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:41:56.575838) ========= ========= Total master_lag: 0.19 =========