builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1475760058.67 results: success (0) buildid: 20161006043005 builduid: 1b698e3980644240ba738fbd9e3282ca revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.666599) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.667060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.667422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.699408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.699712) ========= 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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 06:20:58-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.8M=0s 2016-10-06 06:20:59 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.841257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.841538) ========= 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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020785 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.893706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:58.894058) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 777fb63db8de8d78b64b8141d1a998397275dd03 --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 777fb63db8de8d78b64b8141d1a998397275dd03 --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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 06:20:59,165 truncating revision to first 12 chars 2016-10-06 06:20:59,165 Setting DEBUG logging. 2016-10-06 06:20:59,165 attempt 1/10 2016-10-06 06:20:59,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/777fb63db8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 06:20:59,463 unpacking tar archive at: mozilla-central-777fb63db8de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609644 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:59.516821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:59.517119) ========= script_repo_revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:59.517603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:59.517947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:20:59.528137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 06:20:59.528571) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:20:59 INFO - MultiFileLogger online at 20161006 06:20:59 in /builds/slave/test 06:20:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:20:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:20:59 INFO - {'append_to_log': False, 06:20:59 INFO - 'base_work_dir': '/builds/slave/test', 06:20:59 INFO - 'blob_upload_branch': 'Firefox', 06:20:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:20:59 INFO - 'branch': 'Firefox', 06:20:59 INFO - 'buildbot_json_path': 'buildprops.json', 06:20:59 INFO - 'config_files': ('talos/linux_config.py',), 06:20:59 INFO - 'default_actions': ('clobber', 06:20:59 INFO - 'read-buildbot-config', 06:20:59 INFO - 'download-and-extract', 06:20:59 INFO - 'populate-webroot', 06:20:59 INFO - 'create-virtualenv', 06:20:59 INFO - 'install', 06:20:59 INFO - 'run-tests'), 06:20:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:20:59 INFO - 'download_minidump_stackwalk': True, 06:20:59 INFO - 'download_symbols': 'ondemand', 06:20:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:20:59 INFO - 'tooltool.py': '/tools/tooltool.py', 06:20:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:20:59 INFO - '/tools/misc-python/virtualenv.py')}, 06:20:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:20:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:20:59 INFO - 'installer_path': 'installer.exe', 06:20:59 INFO - 'log_level': 'info', 06:20:59 INFO - 'log_name': 'talos', 06:20:59 INFO - 'log_to_console': True, 06:20:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:20:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:20:59 INFO - 'opt_config_files': (), 06:20:59 INFO - 'pip_index': False, 06:20:59 INFO - 'sps_profile': False, 06:20:59 INFO - 'sps_profile_interval': 0, 06:20:59 INFO - 'suite': 'dromaeojs', 06:20:59 INFO - 'system_bits': '32', 06:20:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:20:59 INFO - 'title': 'talos-linux64-ix-045', 06:20:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:20:59 INFO - 'use_talos_json': True, 06:20:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:20:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:20:59 INFO - 'work_dir': 'build'} 06:20:59 INFO - [mozharness: 2016-10-06 13:20:59.901217Z] Running clobber step. 06:20:59 INFO - Running pre-action listener: _resource_record_pre_action 06:20:59 INFO - Running main action method: clobber 06:20:59 INFO - rmtree: /builds/slave/test/build 06:20:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:00 INFO - Running post-action listener: _resource_record_post_action 06:21:00 INFO - [mozharness: 2016-10-06 13:21:00.887367Z] Finished clobber step (success) 06:21:00 INFO - [mozharness: 2016-10-06 13:21:00.887468Z] Running read-buildbot-config step. 06:21:00 INFO - Running pre-action listener: _resource_record_pre_action 06:21:00 INFO - Running main action method: read_buildbot_config 06:21:00 INFO - Using buildbot properties: 06:21:00 INFO - { 06:21:00 INFO - "project": "", 06:21:00 INFO - "product": "firefox", 06:21:00 INFO - "script_repo_revision": "production", 06:21:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:21:00 INFO - "repository": "", 06:21:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:21:00 INFO - "buildid": "20161006043005", 06:21:00 INFO - "pgo_build": "True", 06:21:00 INFO - "basedir": "/builds/slave/test", 06:21:00 INFO - "buildnumber": 21, 06:21:00 INFO - "slavename": "talos-linux64-ix-045", 06:21:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:21:00 INFO - "platform": "ubuntu64_hw", 06:21:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:21:00 INFO - "branch": "mozilla-central", 06:21:00 INFO - "repo_path": "mozilla-central", 06:21:00 INFO - "revision": "777fb63db8de8d78b64b8141d1a998397275dd03", 06:21:00 INFO - "stage_platform": "linux64-pgo", 06:21:00 INFO - "builduid": "1b698e3980644240ba738fbd9e3282ca", 06:21:00 INFO - "slavebuilddir": "test" 06:21:00 INFO - } 06:21:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:21:00 INFO - Running post-action listener: _resource_record_post_action 06:21:00 INFO - [mozharness: 2016-10-06 13:21:00.889911Z] Finished read-buildbot-config step (success) 06:21:00 INFO - [mozharness: 2016-10-06 13:21:00.890000Z] Running download-and-extract step. 06:21:00 INFO - Running pre-action listener: _resource_record_pre_action 06:21:00 INFO - Running main action method: download_and_extract 06:21:00 INFO - mkdir: /builds/slave/test/build/tests 06:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:00 INFO - trying https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:21:01 INFO - Downloaded 1361 bytes. 06:21:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:21:01 INFO - Using the following test package requirements: 06:21:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:21:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:21:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'jsshell-linux-x86_64.zip'], 06:21:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:21:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:21:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:21:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:21:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:21:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:21:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:21:01 INFO - Http code: 200 06:21:01 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 06:21:01 INFO - x-amz-cf-id: BEFM5k6z3lvrRSk5wY8Njf_FQEfiuoYqnHOna0toC94BrUX19h80jg== 06:21:01 INFO - x-amz-version-id: ll4Yj1bcVpUiO9jycHoMSKcBLANji0fd 06:21:02 INFO - Expected file size: 22017850 06:21:02 INFO - Obtained file size: 22017850 06:21:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:21:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:21:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:21:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:21:06 INFO - Http code: 200 06:21:06 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 06:21:06 INFO - x-amz-cf-id: IXzoYafLg3HyXhIZwk27xDN0sRJzP64ufr9uRDri_GxV3p3rTpZuAg== 06:21:06 INFO - x-amz-version-id: ll4Yj1bcVpUiO9jycHoMSKcBLANji0fd 06:21:07 INFO - Expected file size: 22017850 06:21:07 INFO - Obtained file size: 22017850 06:21:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:21:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:21:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:21:12 INFO - Http code: 200 06:21:12 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 06:21:12 INFO - x-amz-cf-id: Xwd_GP4PnrocAJ9Df3-Qf-RrqID4Sk5g6AdFjQV0805jqQC-9T1kwg== 06:21:12 INFO - x-amz-version-id: 1PrfkjqaJAQNJB_9WvcofpBJc5iZecmR 06:21:12 INFO - Expected file size: 14409006 06:21:12 INFO - Obtained file size: 14409006 06:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:12 INFO - trying https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:21:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:21:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:21:14 INFO - Downloaded 59709173 bytes. 06:21:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:21:14 INFO - mkdir: /builds/slave/test/properties 06:21:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:14 INFO - Contents: 06:21:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:21:15 INFO - Running post-action listener: _resource_record_post_action 06:21:15 INFO - Running post-action listener: set_extra_try_arguments 06:21:15 INFO - [mozharness: 2016-10-06 13:21:15.106937Z] Finished download-and-extract step (success) 06:21:15 INFO - [mozharness: 2016-10-06 13:21:15.107163Z] Running populate-webroot step. 06:21:15 INFO - Running pre-action listener: _resource_record_pre_action 06:21:15 INFO - Running main action method: populate_webroot 06:21:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:15 INFO - '--tppagecycles', 06:21:15 INFO - '7'], 06:21:15 INFO - 'tests': ['tsvgm']}}, 06:21:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['damp', 'tps']}, 06:21:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'tests': ['damp', 'tps']}, 06:21:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['dromaeo_dom']}, 06:21:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['basic_compositor_video']}, 06:21:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:21:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['a11yr', 06:21:15 INFO - 'ts_paint', 06:21:15 INFO - 'tpaint', 06:21:15 INFO - 'sessionrestore', 06:21:15 INFO - 'sessionrestore_no_auto_restore', 06:21:15 INFO - 'tabpaint']}, 06:21:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['tsvgx', 06:21:15 INFO - 'tsvgr_opacity', 06:21:15 INFO - 'tart', 06:21:15 INFO - 'tscrollx', 06:21:15 INFO - 'cart']}, 06:21:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:15 INFO - 'tsvgr_opacity', 06:21:15 INFO - 'tart', 06:21:15 INFO - 'tscrollx', 06:21:15 INFO - 'cart']}, 06:21:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'talos_options': ['--disable-e10s'], 06:21:15 INFO - 'tests': ['tp5o']}, 06:21:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'tests': ['tp5o']}, 06:21:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'talos_options': ['--disable-e10s', 06:21:15 INFO - '--xperf_path', 06:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:15 INFO - 'tests': ['tp5n']}, 06:21:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:15 INFO - 'talos_options': ['--xperf_path', 06:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:15 INFO - 'tests': ['tp5n']}}, 06:21:15 INFO - 'talos.zip': {'path': '', 06:21:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:15 INFO - Running post-action listener: _resource_record_post_action 06:21:15 INFO - [mozharness: 2016-10-06 13:21:15.124700Z] Finished populate-webroot step (success) 06:21:15 INFO - [mozharness: 2016-10-06 13:21:15.124789Z] Running create-virtualenv step. 06:21:15 INFO - Running pre-action listener: _resource_record_pre_action 06:21:15 INFO - Running main action method: create_virtualenv 06:21:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:15 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 06:21:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:15 INFO - Using real prefix '/usr' 06:21:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:17 INFO - Installing pip.................done. 06:21:17 INFO - Return code: 0 06:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:21:17 INFO - Reading from file tmpfile_stdout 06:21:17 INFO - Output received: 06:21:17 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) 06:21:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:17 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')]} 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 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')]} 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:17 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 06:21:17 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 06:21:17 INFO - Using env: {'DISPLAY': ':0', 06:21:17 INFO - 'HOME': '/home/cltbld', 06:21:17 INFO - 'LANG': 'en_US.UTF-8', 06:21:17 INFO - 'LANGUAGE': 'en_US:en', 06:21:17 INFO - 'LOGNAME': 'cltbld', 06:21:17 INFO - 'MAIL': '/var/mail/cltbld', 06:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:17 INFO - 'MOZ_NO_REMOTE': '1', 06:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:17 INFO - 'NO_EM_RESTART': '1', 06:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:17 INFO - 'PWD': '/builds/slave/test', 06:21:17 INFO - 'SHELL': '/bin/bash', 06:21:17 INFO - 'SHLVL': '1', 06:21:17 INFO - 'TERM': 'linux', 06:21:17 INFO - 'TMOUT': '86400', 06:21:17 INFO - 'USER': 'cltbld', 06:21:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:17 INFO - '_': '/tools/buildbot/bin/python'} 06:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:18 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 06:21:18 INFO - Cleaning up... 06:21:18 INFO - Return code: 0 06:21:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:18 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:18 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 06:21:18 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 06:21:18 INFO - Using env: {'DISPLAY': ':0', 06:21:18 INFO - 'HOME': '/home/cltbld', 06:21:18 INFO - 'LANG': 'en_US.UTF-8', 06:21:18 INFO - 'LANGUAGE': 'en_US:en', 06:21:18 INFO - 'LOGNAME': 'cltbld', 06:21:18 INFO - 'MAIL': '/var/mail/cltbld', 06:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:18 INFO - 'MOZ_NO_REMOTE': '1', 06:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:18 INFO - 'NO_EM_RESTART': '1', 06:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:18 INFO - 'PWD': '/builds/slave/test', 06:21:18 INFO - 'SHELL': '/bin/bash', 06:21:18 INFO - 'SHLVL': '1', 06:21:18 INFO - 'TERM': 'linux', 06:21:18 INFO - 'TMOUT': '86400', 06:21:18 INFO - 'USER': 'cltbld', 06:21:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:18 INFO - '_': '/tools/buildbot/bin/python'} 06:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:18 INFO - Downloading/unpacking psutil>=3.1.1 06:21:18 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 06:21:18 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 06:21:18 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 06:21:18 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 06:21:18 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 06:21:18 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 06:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:20 INFO - Installing collected packages: psutil 06:21:20 INFO - Running setup.py install for psutil 06:21:20 INFO - building 'psutil._psutil_linux' extension 06:21:20 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 06:21:20 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 06:21:20 INFO - building 'psutil._psutil_posix' extension 06:21:20 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 06:21:20 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 06:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:20 INFO - Successfully installed psutil 06:21:20 INFO - Cleaning up... 06:21:20 INFO - Return code: 0 06:21:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:21:20 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')]} 06:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:20 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')]} 06:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:20 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:20 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 06:21:20 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 06:21:20 INFO - Using env: {'DISPLAY': ':0', 06:21:20 INFO - 'HOME': '/home/cltbld', 06:21:20 INFO - 'LANG': 'en_US.UTF-8', 06:21:20 INFO - 'LANGUAGE': 'en_US:en', 06:21:20 INFO - 'LOGNAME': 'cltbld', 06:21:20 INFO - 'MAIL': '/var/mail/cltbld', 06:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:20 INFO - 'MOZ_NO_REMOTE': '1', 06:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:20 INFO - 'NO_EM_RESTART': '1', 06:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:20 INFO - 'PWD': '/builds/slave/test', 06:21:20 INFO - 'SHELL': '/bin/bash', 06:21:20 INFO - 'SHLVL': '1', 06:21:20 INFO - 'TERM': 'linux', 06:21:20 INFO - 'TMOUT': '86400', 06:21:20 INFO - 'USER': 'cltbld', 06:21:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:20 INFO - '_': '/tools/buildbot/bin/python'} 06:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:21:21 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 06:21:21 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 06:21:21 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 06:21:21 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 06:21:21 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 06:21:21 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 06:21:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:21:23 INFO - Installing collected packages: mozsystemmonitor 06:21:23 INFO - Running setup.py install for mozsystemmonitor 06:21:23 INFO - Successfully installed mozsystemmonitor 06:21:23 INFO - Cleaning up... 06:21:23 INFO - Return code: 0 06:21:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:21:23 INFO - Using env: {'DISPLAY': ':0', 06:21:23 INFO - 'HOME': '/home/cltbld', 06:21:23 INFO - 'LANG': 'en_US.UTF-8', 06:21:23 INFO - 'LANGUAGE': 'en_US:en', 06:21:23 INFO - 'LOGNAME': 'cltbld', 06:21:23 INFO - 'MAIL': '/var/mail/cltbld', 06:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:23 INFO - 'MOZ_NO_REMOTE': '1', 06:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:23 INFO - 'NO_EM_RESTART': '1', 06:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:23 INFO - 'PWD': '/builds/slave/test', 06:21:23 INFO - 'SHELL': '/bin/bash', 06:21:23 INFO - 'SHLVL': '1', 06:21:23 INFO - 'TERM': 'linux', 06:21:23 INFO - 'TMOUT': '86400', 06:21:23 INFO - 'USER': 'cltbld', 06:21:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:23 INFO - '_': '/tools/buildbot/bin/python'} 06:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:21:25 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 06:21:25 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 06:21:25 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 06:21:25 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 06:21:25 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 06:21:25 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 06:21:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:25 INFO - warning: no files found matching '*.txt' 06:21:25 INFO - no previously-included directories found matching 'build' 06:21:25 INFO - no previously-included directories found matching 'dist' 06:21:25 INFO - no previously-included directories found matching '.git*' 06:21:25 INFO - Installing collected packages: jsonschema, functools32 06:21:25 INFO - Running setup.py install for functools32 06:21:25 INFO - warning: no files found matching '*.txt' 06:21:25 INFO - no previously-included directories found matching 'build' 06:21:25 INFO - no previously-included directories found matching 'dist' 06:21:25 INFO - no previously-included directories found matching '.git*' 06:21:25 INFO - Successfully installed jsonschema functools32 06:21:25 INFO - Cleaning up... 06:21:25 INFO - Return code: 0 06:21:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:25 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:25 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 06:21:25 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 06:21:25 INFO - Using env: {'DISPLAY': ':0', 06:21:25 INFO - 'HOME': '/home/cltbld', 06:21:25 INFO - 'LANG': 'en_US.UTF-8', 06:21:25 INFO - 'LANGUAGE': 'en_US:en', 06:21:25 INFO - 'LOGNAME': 'cltbld', 06:21:25 INFO - 'MAIL': '/var/mail/cltbld', 06:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:25 INFO - 'MOZ_NO_REMOTE': '1', 06:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:25 INFO - 'NO_EM_RESTART': '1', 06:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:25 INFO - 'PWD': '/builds/slave/test', 06:21:25 INFO - 'SHELL': '/bin/bash', 06:21:25 INFO - 'SHLVL': '1', 06:21:25 INFO - 'TERM': 'linux', 06:21:25 INFO - 'TMOUT': '86400', 06:21:25 INFO - 'USER': 'cltbld', 06:21:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:25 INFO - '_': '/tools/buildbot/bin/python'} 06:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:21:26 INFO - Cleaning up... 06:21:26 INFO - Return code: 0 06:21:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:21:26 INFO - Using env: {'DISPLAY': ':0', 06:21:26 INFO - 'HOME': '/home/cltbld', 06:21:26 INFO - 'LANG': 'en_US.UTF-8', 06:21:26 INFO - 'LANGUAGE': 'en_US:en', 06:21:26 INFO - 'LOGNAME': 'cltbld', 06:21:26 INFO - 'MAIL': '/var/mail/cltbld', 06:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:26 INFO - 'MOZ_NO_REMOTE': '1', 06:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:26 INFO - 'NO_EM_RESTART': '1', 06:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:26 INFO - 'PWD': '/builds/slave/test', 06:21:26 INFO - 'SHELL': '/bin/bash', 06:21:26 INFO - 'SHLVL': '1', 06:21:26 INFO - 'TERM': 'linux', 06:21:26 INFO - 'TMOUT': '86400', 06:21:26 INFO - 'USER': 'cltbld', 06:21:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:26 INFO - '_': '/tools/buildbot/bin/python'} 06:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 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 06:21:28 INFO - Downloading docopt-0.6.1.tar.gz 06:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:28 INFO - Running setup.py install for blobuploader 06:21:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:29 INFO - Running setup.py install for requests 06:21:29 INFO - Running setup.py install for docopt 06:21:29 INFO - Successfully installed blobuploader requests docopt 06:21:29 INFO - Cleaning up... 06:21:29 INFO - Return code: 0 06:21:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:29 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')]} 06:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:29 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')]} 06:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:29 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:29 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 06:21:29 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 06:21:29 INFO - Using env: {'DISPLAY': ':0', 06:21:29 INFO - 'HOME': '/home/cltbld', 06:21:29 INFO - 'LANG': 'en_US.UTF-8', 06:21:29 INFO - 'LANGUAGE': 'en_US:en', 06:21:29 INFO - 'LOGNAME': 'cltbld', 06:21:29 INFO - 'MAIL': '/var/mail/cltbld', 06:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:29 INFO - 'MOZ_NO_REMOTE': '1', 06:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:29 INFO - 'NO_EM_RESTART': '1', 06:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:29 INFO - 'PWD': '/builds/slave/test', 06:21:29 INFO - 'SHELL': '/bin/bash', 06:21:29 INFO - 'SHLVL': '1', 06:21:29 INFO - 'TERM': 'linux', 06:21:29 INFO - 'TMOUT': '86400', 06:21:29 INFO - 'USER': 'cltbld', 06:21:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:29 INFO - '_': '/tools/buildbot/bin/python'} 06:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:29 INFO - Running setup.py (path:/tmp/pip-RKD6VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:29 INFO - Running setup.py (path:/tmp/pip-l2llND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:29 INFO - Running setup.py (path:/tmp/pip-y3G5jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:29 INFO - Running setup.py (path:/tmp/pip-BCaoaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:30 INFO - Running setup.py (path:/tmp/pip-cQsV0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:30 INFO - Running setup.py (path:/tmp/pip-Pf4Px1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:30 INFO - Running setup.py (path:/tmp/pip-IHuokq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:30 INFO - Running setup.py (path:/tmp/pip-5QVc5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:30 INFO - Running setup.py (path:/tmp/pip-1xot4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:30 INFO - Running setup.py (path:/tmp/pip-DzVMVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:30 INFO - Running setup.py (path:/tmp/pip-kkZybd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:30 INFO - Running setup.py (path:/tmp/pip-qHDDi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:30 INFO - Running setup.py (path:/tmp/pip-bhZXXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:30 INFO - Running setup.py (path:/tmp/pip-tu1PMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:30 INFO - Running setup.py (path:/tmp/pip-x6U5vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:30 INFO - Running setup.py (path:/tmp/pip-EWHj_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:30 INFO - Running setup.py (path:/tmp/pip-F39xH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:30 INFO - Running setup.py install for manifestparser 06:21:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozcrash 06:21:31 INFO - Running setup.py install for mozdebug 06:21:31 INFO - Running setup.py install for mozdevice 06:21:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozfile 06:21:31 INFO - Running setup.py install for mozhttpd 06:21:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozinfo 06:21:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozInstall 06:21:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozleak 06:21:31 INFO - Running setup.py install for mozlog 06:21:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for moznetwork 06:21:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozprocess 06:21:32 INFO - Running setup.py install for mozprofile 06:21:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozrunner 06:21:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozscreenshot 06:21:32 INFO - Running setup.py install for moztest 06:21:32 INFO - Running setup.py install for mozversion 06:21:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:32 INFO - Cleaning up... 06:21:32 INFO - Return code: 0 06:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06: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')]} 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:32 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 06:21:32 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 06:21:32 INFO - Using env: {'DISPLAY': ':0', 06:21:32 INFO - 'HOME': '/home/cltbld', 06:21:32 INFO - 'LANG': 'en_US.UTF-8', 06:21:32 INFO - 'LANGUAGE': 'en_US:en', 06:21:32 INFO - 'LOGNAME': 'cltbld', 06:21:32 INFO - 'MAIL': '/var/mail/cltbld', 06:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:32 INFO - 'MOZ_NO_REMOTE': '1', 06:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:32 INFO - 'NO_EM_RESTART': '1', 06:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:32 INFO - 'PWD': '/builds/slave/test', 06:21:32 INFO - 'SHELL': '/bin/bash', 06:21:32 INFO - 'SHLVL': '1', 06:21:32 INFO - 'TERM': 'linux', 06:21:32 INFO - 'TMOUT': '86400', 06:21:32 INFO - 'USER': 'cltbld', 06:21:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:32 INFO - '_': '/tools/buildbot/bin/python'} 06:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:32 INFO - Running setup.py (path:/tmp/pip-3siHZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:33 INFO - Running setup.py (path:/tmp/pip-LxOAiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 INFO - Running setup.py (path:/tmp/pip-avx2bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 INFO - Running setup.py (path:/tmp/pip-_RA9pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:33 INFO - Running setup.py (path:/tmp/pip-9eKa2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 INFO - Running setup.py (path:/tmp/pip-SKqNHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 INFO - Running setup.py (path:/tmp/pip-Ih2j5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 INFO - Running setup.py (path:/tmp/pip-wISBN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:33 INFO - Running setup.py (path:/tmp/pip-tiBHQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:33 INFO - Running setup.py (path:/tmp/pip-ZRfd0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 INFO - Running setup.py (path:/tmp/pip-6dDDWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:33 INFO - Running setup.py (path:/tmp/pip-rxBUC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:33 INFO - Running setup.py (path:/tmp/pip-4LWmSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:33 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)) 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:33 INFO - Running setup.py (path:/tmp/pip-G4gYEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:34 INFO - Running setup.py (path:/tmp/pip-lldyJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:34 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)) 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:34 INFO - Running setup.py (path:/tmp/pip-Z5i4ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:34 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)) 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:34 INFO - Running setup.py (path:/tmp/pip-PbtgAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:34 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)) 06:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:34 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)) 06:21:34 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)) 06:21:34 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)) 06:21:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:36 INFO - Downloading blessings-1.6.tar.gz 06:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:36 INFO - Installing collected packages: blessings 06:21:36 INFO - Running setup.py install for blessings 06:21:36 INFO - Successfully installed blessings 06:21:36 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:36 INFO - Reading from file tmpfile_stdout 06:21:36 INFO - Current package versions: 06:21:36 INFO - argparse == 1.2.1 06:21:36 INFO - blessings == 1.6 06:21:36 INFO - blobuploader == 1.2.4 06:21:36 INFO - docopt == 0.6.1 06:21:36 INFO - functools32 == 3.2.3-2 06:21:36 INFO - jsonschema == 2.5.1 06:21:36 INFO - manifestparser == 1.1 06:21:36 INFO - mozInstall == 1.12 06:21:36 INFO - mozcrash == 0.17 06:21:36 INFO - mozdebug == 0.1 06:21:36 INFO - mozdevice == 0.48 06:21:36 INFO - mozfile == 1.2 06:21:36 INFO - mozhttpd == 0.7 06:21:36 INFO - mozinfo == 0.9 06:21:36 INFO - mozleak == 0.1 06:21:36 INFO - mozlog == 3.4 06:21:36 INFO - moznetwork == 0.27 06:21:36 INFO - mozprocess == 0.23 06:21:36 INFO - mozprofile == 0.28 06:21:36 INFO - mozrunner == 6.12 06:21:36 INFO - mozscreenshot == 0.1 06:21:36 INFO - mozsystemmonitor == 0.3 06:21:36 INFO - moztest == 0.7 06:21:36 INFO - mozversion == 1.4 06:21:36 INFO - psutil == 3.1.1 06:21:36 INFO - requests == 1.2.3 06:21:36 INFO - wsgiref == 0.1.2 06:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:36 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')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:36 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 06:21:36 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 06:21:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 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)) 06:21:36 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:36 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')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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 0x7f2f14408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, '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': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', '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 06:21:36 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 06:21:36 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 06:21:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:21:37 INFO - Cleaning up... 06:21:37 INFO - Return code: 0 06:21:37 INFO - Running post-action listener: _resource_record_post_action 06:21:37 INFO - Running post-action listener: _start_resource_monitoring 06:21:37 INFO - Starting resource monitoring. 06:21:37 INFO - [mozharness: 2016-10-06 13:21:37.078619Z] Finished create-virtualenv step (success) 06:21:37 INFO - [mozharness: 2016-10-06 13:21:37.079140Z] Running install step. 06:21:37 INFO - Running pre-action listener: _resource_record_pre_action 06:21:37 INFO - Running main action method: install 06:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:37 INFO - Reading from file tmpfile_stdout 06:21:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:37 INFO - Reading from file tmpfile_stdout 06:21:37 INFO - Output received: 06:21:37 INFO - Usage: mozinstall [options] installer 06:21:37 INFO - Options: 06:21:37 INFO - -h, --help show this help message and exit 06:21:37 INFO - -d DEST, --destination=DEST 06:21:37 INFO - Directory to install application into. [default: 06:21:37 INFO - "/builds/slave/test"] 06:21:37 INFO - --app=APP Application being installed. [default: firefox] 06:21:37 INFO - mkdir: /builds/slave/test/build/application 06:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:21:54 INFO - Reading from file tmpfile_stdout 06:21:54 INFO - Output received: 06:21:54 INFO - /builds/slave/test/build/application/firefox/firefox 06:21:54 INFO - Running post-action listener: _resource_record_post_action 06:21:54 INFO - [mozharness: 2016-10-06 13:21:54.401070Z] Finished install step (success) 06:21:54 INFO - [mozharness: 2016-10-06 13:21:54.401315Z] Running run-tests step. 06:21:54 INFO - Running pre-action listener: _resource_record_pre_action 06:21:54 INFO - Running main action method: run_tests 06:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:54 INFO - Python 2.7.3 06:21:54 INFO - Return code: 0 06:21:54 INFO - grabbing minidump binary from tooltool 06:21:54 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')]} 06:21:54 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 0x1830930>, '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 0x1831830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:54 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 06:21:54 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 06:21:54 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 06:21:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:54 INFO - Return code: 0 06:21:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:21:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:21:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:21:54 INFO - Using env: {'DISPLAY': ':0', 06:21:54 INFO - 'HOME': '/home/cltbld', 06:21:54 INFO - 'LANG': 'en_US.UTF-8', 06:21:54 INFO - 'LANGUAGE': 'en_US:en', 06:21:54 INFO - 'LOGNAME': 'cltbld', 06:21:54 INFO - 'MAIL': '/var/mail/cltbld', 06:21:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:54 INFO - 'MOZ_NO_REMOTE': '1', 06:21:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:54 INFO - 'NO_EM_RESTART': '1', 06:21:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:54 INFO - 'PWD': '/builds/slave/test', 06:21:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:54 INFO - 'SHELL': '/bin/bash', 06:21:54 INFO - 'SHLVL': '1', 06:21:54 INFO - 'TERM': 'linux', 06:21:54 INFO - 'TMOUT': '86400', 06:21:54 INFO - 'USER': 'cltbld', 06:21:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475759784.915697-1065746786', 06:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:54 INFO - '_': '/tools/buildbot/bin/python'} 06:21:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:21:54 INFO - mozversion application_buildid: 20161006043005 06:21:54 INFO - mozversion application_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 06:21:54 INFO - mozversion application_display_name: Nightly 06:21:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:54 INFO - mozversion application_name: Firefox 06:21:54 INFO - mozversion application_remotingname: firefox 06:21:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:21:54 INFO - mozversion application_vendor: Mozilla 06:21:54 INFO - mozversion application_version: 52.0a1 06:21:54 INFO - mozversion platform_buildid: 20161006043005 06:21:54 INFO - mozversion platform_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 06:21:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:21:54 INFO - mozversion platform_version: 52.0a1 06:21:54 INFO - using testdate: 1475760114 06:21:54 INFO - actual date: 1475760114 06:21:54 INFO - starting webserver on 'localhost:50597' 06:21:54 INFO - SUITE-START | Running 2 tests 06:21:54 INFO - TEST-START | dromaeo_css 06:21:54 INFO - operating with platform_type : linux_ 06:21:54 INFO - Initialising browser for dromaeo_css test... 06:21:54 INFO - TEST-INFO | started process 27520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVMvix/profile http://localhost:50597/getInfo.html) 06:21:59 INFO - PROCESS | 27520 | __metrics Screen width/height:1600/1200 06:21:59 INFO - PROCESS | 27520 | colorDepth:24 06:21:59 INFO - PROCESS | 27520 | Browser inner width/height: 1024/697 06:21:59 INFO - PROCESS | 27520 | __metrics 06:21:59 INFO - PROCESS | 27520 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:59 INFO - PROCESS | 27520 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:22:00 INFO - PROCESS | 27520 | console.error: PushService: 06:22:00 INFO - PROCESS | 27520 | stateChangeProcessEnqueue: Error transitioning state 06:22:00 INFO - PROCESS | 27520 | UnknownError 06:22:01 INFO - TEST-INFO | 27520: exit 0 06:22:01 INFO - Browser initialized. 06:22:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:01 INFO - TEST-INFO | started process 27603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprVMvix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:13 INFO - PROCESS | 27603 | RSS: Main: 173895680 06:22:13 INFO - PROCESS | 27603 | 06:23:04 INFO - PROCESS | 27603 | 1475760184342 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] 06:25:15 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50597/tests/dromaeo/cssquery-ext.html) 06:25:16 INFO - PROCESS | 27603 | RSS: Main: 325586944 06:25:16 INFO - PROCESS | 27603 | 06:28:19 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-ext.html (next: http://localhost:50597/tests/dromaeo/cssquery-jquery.html) 06:28:19 INFO - PROCESS | 27603 | RSS: Main: 268578816 06:28:19 INFO - PROCESS | 27603 | 06:31:21 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50597/tests/dromaeo/cssquery-mootools.html) 06:31:22 INFO - PROCESS | 27603 | RSS: Main: 215154688 06:31:22 INFO - PROCESS | 27603 | 06:34:24 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50597/tests/dromaeo/cssquery-prototype.html) 06:34:24 INFO - PROCESS | 27603 | RSS: Main: 258850816 06:34:24 INFO - PROCESS | 27603 | 06:37:27 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50597/tests/dromaeo/cssquery-yui.html) 06:37:28 INFO - PROCESS | 27603 | RSS: Main: 215945216 06:37:28 INFO - PROCESS | 27603 | 06:40:30 INFO - PROCESS | 27603 | Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-yui.html (next: http://localhost:50597/tests/dromaeo/cssquery-dojo.html) 06:40:31 INFO - PROCESS | 27603 | RSS: Main: 300437504 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | __start_tp_report 06:40:31 INFO - PROCESS | 27603 | _x_x_mozilla_page_load 06:40:31 INFO - PROCESS | 27603 | _x_x_mozilla_page_load_details 06:40:31 INFO - PROCESS | 27603 | |i|pagename|runs| 06:40:31 INFO - PROCESS | 27603 | |0;dojo.html;2970.5395663672125;3008.18778929689;3016.381641763439;3023.6673965863765;3040.5591189277548;5116.539511443969;5195.350581177353;5214.061468935595;5287.682739035656;5293.047251494734;5219.321488206538;5230.816921407752;5304.3634763828295;5347.465253474651;5363;4731.077439899221;4747.643926705511;4757.738324392157;4774.28385742138;4869.634777391692;4902.3872015998;4924.507549245065;4939.555440010398;4943.332650092228;4975.701457912519;4679.415073115861;4738.384010078702;4738.47876733559;4802.543758342969;4813.013332266877;4799.832005879813;4803.879903002418;4809.446913604946;4812.446568644581;4814.518548145193;4723.504032076617;4737.526247375269;4744.6441516886025;4744.810207591692;4747.026859493795;5116.104681680691;5176.5858731301405;5209.114450543417;5220.373555173365;5232.947670523284;5487.42382049883;5569.972150139264;5578.30271216098;5588.608797384185;5590.580706447033;5692.516136128393;5693.430656934315;5700.600957932947;5702.201691763156;5705.1727499512335;5073.086844367976;5128.79484820603;5224.111900976843;5308.416074231832;5375.16684913839;5590.993621148233;5611.6071874969175;5629.380768115504;5630.8029218977135;5646.745896434671;5408.675479471244;5416.647917885325;5418.945810541923;5422.15956526739;5427.43011983744;5378;5435.809746658927;5495.835124946258;5495.945040549544;5562.833115006556;5533.944660553423;5573.331200255995;5582.692951887685;5599.216109744558;5599.972000139973;5553.694546799884;5556;5558.694271815089;5609.354924183689;5616.073347897551;4294.205571969195;4294.9785251073545;4301.118270754488;4304.289792184254;4349.151915376471;3808.6762625176616;3828.8277027533827;3833.4824798652385;3866.3233934061427;3877.6122387760997;5311.575073994071;5322.680639161663;5396.298481197419;5428.565714742811;5431.266778984866;5520.199571062173;5551.195076713854;5599.8600034998635;5603.691796951207;5606.439356064361;5170.663906846043;5218.08683480397;5313.946860531422;5322.441143679858;5371.57027437804;4838.588719958843;4883.34074899891;4890.926636100461;4919.704817710877;4973.303737476756;5795.710214489343;5828.358880523224;5831.212786273799;5836.649801011868;5860.824175274749;5412.323459567554;5626.071698169756;5638.661680299195;5642.379338272704;5647.463490968352;5654;5669.574781891292;5714.228579141763;5720.027595308724;5817.331006934088;5394.838154855361;5430.049741295336;5431.701256430934;5442.8639284016635;5451.509364157245;5455.536279416136;5511.118221084607;5512.641678290898;5516.613837031369;5585.497305242548;5360.973195133999;5416.674999500043;5441.564674826083;5483.561315094863;5499.285092938053;5492.395836457907;5492.780288788404;5496.5053145217125;5500.669959802424;5542.889142217214;5402.35171779389;5414.83755487336;5418.539424148991;5422.539084177889;5505.284313039279;5413.323334583177;5433.103537916358;5446.836594902159;5479.0959491683425;5525.723713814374;5359.169328754049;5362.570994320367;5369.248305237348;5421.945780542144;5439.972800135974 06:40:31 INFO - PROCESS | 27603 | |1;ext.html;549.5230785025985;586.9589128760987;589.1839801874403;595.2172892646173;617.4689766800551;30816;41700.16599668009;42753.14493710124;42779.786101069454;46035.539644603545;43651.78174109133;44190.11619767603;44192.55807441925;44220.115597688025;44262.336064959054;8019.157988411221;8234.382421318425;8874.334424918141;9002;9029;10404.167666586654;10691.625793097242;10698.251122421434;11003.61487347943;11004.559817607325;10821.783564328709;10920.945395273013;10929.923314570206;10930.781384372307;10936.289141205836;10397.168226541897;10458.111060559824;10465.790684186273;10466.685999419953;10473.162147028219;10480.161587073017;10521.52653130611;10544.420056896868;10551.525181366856;10553.050225479743;41995.79002105001;42175.36736948948;42320;42328.576714232775;42333.576664233275;3504.3867323218333;3520.1727594015388;3584.5698516178227;3644.1254099016046;3959.208158368309;31400.528992065138;31640.525392119136;31668.841655791803;31897.52153717696;32075.839620801748;4070.796460177009;4155.10665206982;4185.937210941838;4214.936775948363;4258.574142585748;324365;327473.3626331877;327583;327939;329084;56848;57131.71434142803;57159;57290;57353;35784.821075894455;36786.448203276974;60078;60114;60195.39804601986;15702.842971570139;15951;15968.92015539938;15973.041617502988;15998.360065597246;12020.338881361435;12303.138780285473;12712.42794074269;13054.216746995211;13092.345382730826;18069.7289540657;18748.25006999732;18769.7184542232;18851.528711782314;19078.713819292723;6673.799786006428;6914.7872680742685;7053.647317634098;7086.326798954195;7184.533005354635;904.4482865452069;991.4051569058507;1022.325265324882;1024.5799222318813;1035.8549803027581;31198.376032479224;31609.525857112163;31965.680343196735;32180;32598.511022334686;1042.3172821801732;1068.738159151013;1085.1590017736316;1112.933224006562;1160.22265082395;15197.696046079238;16572.58568535796;16663.833361666228;16755.664886702198;16782.74825877613;542581.7225483241;545753;546456;547178;547977;56629.716851416306;57158.42841571531;57168;57246.713766431734;57385.26995745346;1229.6065259117177;1235.5490246060124;1266.7593157300084;1308.378520202896;1368.9540771782704;29950.550741739327;32511.18722031968;32586.185345366557;32625.836870815496;32629.510557342135;47958.5204147968;48541;48550.75724621354;48578.5142148574;48663.27005094997;400035;403462;404231;404678.22809237323;405456.69988150935;27260.454790903674;27801.304967375978;28320.751887217084;28457.857710711312;29540;45672.31491527563;45862;46385.536144639475;46772;47049.2942605868;37331;37614.811925940194;37622.8118859404;37756.43365349577;39376;37423.31288343554;37767.433488498245;38873;38986.415203772536;39473.60526394814;38970.2205955885;39205.60794392019;39885.202295953335;40500.59499404968;42761.358579621956;33642.327153457285;35692;35724.28551429009;36106.63893361033;36885.81557092305;27301;27512.724872751016;27553.17340479789;27711.44577108487;27711.861440692668 06:40:31 INFO - PROCESS | 27603 | |2;jquery.html;382.3614563678656;389.36922186058587;397.57260944484676;404.5671131888879;419.897125204325;13215.405306761195;15070.849291507082;18824.717629235554;18928.71606925897;19516;18072;18083.819161808377;18503.444896653087;18604.906975465103;18637.440876773686;5661.179129026299;5675.6878371689545;5907.143464197688;5907.379725128864;5911.645301281937;5398.78404863805;5881.4118588141055;5908.645481271116;5910.729193223456;5917.171595976567;5712.828615141552;5748.396418376073;5870.354261031304;5877.559183061266;5881.617694849821;5770.740316685738;5792;5834.212381328509;5838.620489668179;5839.065749480063;5022.6233032522705;5137.537621614073;5216.58267338612;5247.317848679685;5251.973740131313;22375.216867409727;22715.204967826212;23042.884785576134;23070.192543260906;23255.651165232535;2167.2847960173103;2218.8442273667456;2513.258588716333;2533.607290869918;2806.564982427727;13926.651833704138;14067;14175.503857364944;14543.200123993176;14580.489682861049;1792.1218602884624;1869.4672018474669;1870.8690391672587;1872.101391332168;1883.6986082226779;47528;47970.76014619905;56028;68959.31040689579;71551;9372.1565059145;10157.238207134495;10462.215333849992;10478.895211047791;10537.473126343806;12206.511739530497;13080.411381487856;13127.409266583027;13458.192508449329;13716.931415342859;7105;7215.134183897861;7717.2668596483245;8201.917980820235;8229.917700822914;7918.683252669829;8074.475159114756;8182.7545173644885;8350.117195504119;8352;4770.379850619397;4782.713037217778;4803.430164861852;4809.677338731807;4908.165611845995;1967.1639553189837;1979.3171355882198;2027.3917824652544;2061.814436700704;2063.6388631989344;841.6801615386237;920.6685593186447;939.7313626604166;949.4540639132526;1004.3371374892536;17271.7409238859;17599.91200044017;18401.631967360845;18747.25010999572;18861.52846178829;939.6241503398695;952.9666461673808;955.5222388805597;960.6397600899662;1025.266934142092;10036.146927511098;10118.595256189818;10454.693163354581;10521.579136834594;10540.314879532805;384390;384396;384600;384857;411482;89101.09943953145;90916.54541727249;91469.54265228631;91510;93432.53283733538;948.1229862377273;959.52023988006;968.4479846487575;968.8885778135605;972.1445128287204;15785;15936;16302.67394652124;16518.678505719272;16648.16759162061;28362.85818570894;36986.63013369939;41280.58719412888;41993.58006419897;42225.78887105545;47721.52278477171;53950.73024634852;54480.193565158654;55823.441765581825;56732.14901776394;8230.588470576567;8420.87368689458;8446.366522510714;8559.272461840814;8743;10109.443980580845;11631.59289424866;11945.701357466132;12227;12652.304123273309;9799.902000979899;9870.259730520096;10140.49297535135;10644.308119972176;10706.304090234109;10019.649312274036;10341.9482902585;10481.213908957012;10582.523786429783;10694.89305106939;9578.664746733832;9930.751731206778;10058.899411005796;10368.066873981377;10810.027097561257;8226.424150309422;8293.917060829315;8329.875051874105;8342;8567.528785916835;10064.69805905824;10216.642417515352;10276.537555809857;10439.895601044196;10529.4735263235 06:40:31 INFO - PROCESS | 27603 | |3;mootools.html;1392.5822253324004;1443.6246575890268;1535.8310585835557;1780.2167046499546;1780.5815633326174;7948.085970113439;8125;8729.91270087299;9181.311401644878;9191.770205744851;8095.635696393661;8363.91636083639;8399.958000210007;8648.135186481364;8673.73978780636;2319.8840057997077;2339.099446713011;2349.95300093998;2352.1179557665873;2358.103920510204;2009.788972157917;2075.533005073861;2282.4065742906796;2290.3129061281634;2343.60158773009;2237.1163390460756;2285.382946604416;2306.042992158261;2330.021391015769;2337.333859849943;2320.524292520029;2357.71707395112;2362.586547354215;2368.230325144335;2368.7157541095007;2314.7685231476885;2327.0924339507606;2333.9183128590416;2335.4394945213025;2335.94160145996;9053.68312109073;9082.818343633156;9089.181973622406;9155.084491550859;9158.038405967343;5172.689638621657;5228.4510126436935;5270.39390470097;5310.681359118426;5314.176302673053;3313.9005829825146;3384.9323013539592;3467.7056796043858;3475.8088305143206;3478.286951175003;1100.6808025672544;1137.994310028453;1145.6792098212513;1170.1867202294409;1173.266708307308;12122.333271670055;12206.755864882742;12219.816702749466;12227.633171004794;12228.633141005696;4421.425214722066;4727.763611819395;4764.285357196448;4817.855464336076;4857.611391088704;10249;10253.231007674454;10256.38461692301;10260.948695256477;10269.845952310572;5369.704666243394;5378.757955891994;5382.273393091961;5384.515393614593;5384.973075134678;4812.975935120372;4900.803967841318;4954.950450495521;4956.157453232959;4958.677685950402;3768.6419790119894;3814.7329686922203;3840.8271627776817;3847.1343947611563;3917.6278253565865;1039.740064983754;1061.3048453263125;1112.232559533919;1142.3888219802366;1156.4275683536703;826.900771907375;894.3828758156851;905.7282815155559;906.8866391701038;914.7804526913626;5658.292713410824;5774.047282198474;5809.244798176294;5864.530837532987;5868.237129173265;912.5619702542816;919.7240827751648;932.9766755831158;937.803061357109;966.2221911361281;3811.923761524754;3915.882523524299;3973.48344715191;4085.387191921176;4106.07613287008;10692.893071069346;10795.190360722978;10944;10960.232783705223;10962.232643714864;10617.84073238902;10786.406747628798;10852.457377131112;10909.563617455213;10915.945420272848;8268.338532917352;8443.408961372645;8512.191341822518;8514.14858514156;8519.701810436605;5959.195508606283;5974.2830860297045;5998.1002849572915;6063.909041364472;6271.150010746932;10076.395416275047;10217.182625389802;10483.633072842718;10490.265681402228;10586.735331616772;10446.582136714447;10558.683239502827;10629.521671524646;10672.733181670521;10709.625163119254;7819.726309579138;7991.960040199761;8079.515229086273;8134.308583770209;8151;8224.547649879314;8358.665653373797;8452.1547845215;8462.746117616482;8484.448510846774;7388.778336649909;7695.345895598937;7708.807279818049;7798.493097948615;7819.569923654253;7402.7409040683315;7443.36731377839;7602.6198690066385;7681.078270607562;7830.09953855314;6976.825579360557;6995.321122930562;7028.824279393056;7044.189918159477;7049.471289653194;4995.549455740728;5037.219231019198;5118.74406279692;5151.5363617274625;5187.870303242449;5072.59419246452;5179.585633149414;5249.580033597379;5258.789648414174;5261.684298942076 06:40:31 INFO - PROCESS | 27603 | |4;prototype.html;336.32231054425336;347.1910448654635;351.5605493133583;356.88579654510534;360.457511445275;5167.689938603687;5280.128778751501;5331.320634000287;5409.079776679281;5436.483534064262;5129.2562578426105;5217.843464696056;5221.373435187773;5248.501392367729;5255.1329030709885;4169;4170.040081161865;4176.561461046592;4187.413762073312;4259.914801703964;4019.437278780973;4183.518895327031;4233.788310584474;4272.9359059614135;4273.145370925828;4170.124273902484;4182.811773470186;4183.477065366829;4186.685998550106;4209.221294060593;4167.937480937803;4173.165366926627;4174.436451079096;4193.6645068394455;4207.600277973587;3780.716446266541;3784.1674831537016;3787.223619158066;3788.408868275331;3804.2201348723447;5060.7722652480725;5112.472394048095;5119.66722163062;5137.460566640524;5210.583153347723;4785.521447855222;4786.712797232177;4790.299443697472;4791.113643975876;4805.303231031481;5431.533485958769;5487.29893732944;5494.917576236359;5497.8075767348355;5538.0031594313;4040.2121586290687;4044.6359827615656;4074.103697186614;4082.6121518455698;4085.3259212229946;5601.747921343549;5631.493165615073;5641.379448260688;5660.915086273709;5669.716514174274;4156.189543039079;4189.183109293719;4199.2441360555395;4228.682848786353;4239.936400953989;4168.7707176105605;4253.214144735203;4267.871963841089;4269.402283680287;4272.124214536013;4736.573708366263;4744.3595114659765;4751.192297309397;4755.334253204554;4760.64295177863;5483.177523371526;5510.531604813636;5513.117901135879;5513.476219759116;5544.722763861791;1353.5600929697691;1360.7890776929592;1449.6520834999524;1460.3574427251974;1468.6989167220695;939.3424602777947;939.9436033837854;965.3001573859036;968.7868668892833;974.3666616699202;4677.859664210079;4690.9765451172525;4704.69419487739;4711.458182309078;4720.952790472052;4875.780589873464;4890.508394939507;4911.575643063543;4984.327115839388;4988.625853061035;4520.773961301922;4696.178168820443;4719.575238228507;4761.976190119097;4767.547083027107;2621.0564196889104;2631.3947792007943;2633.565461698798;2640.231045199721;2672.4387878545335;5072.0109578632555;5115.923261151086;5152.861562451616;5164.32863727713;5164.870878228075;4694.574352296875;4932.8520144395725;4964.503549645079;5009.472111006178;5030.560178313515;5019.698818070928;5070.898582028339;5086.516780905734;5095.8214264302915;5148.588112950955;4886.828960986349;4921.163402221702;4924.679895806761;4939.777710002986;4985.651004429655;4868;4937.456879743154;4938.75306234694;5259.947400526099;5678.886422271614;5778.711064446845;5893.852653683693;5949.345571986992;5951.91072133927;5960.165576819162;4084.387341898739;4130.545639979539;4138.379243113557;4150.937735933903;4154.293770059036;5409.594280428905;5602.215689803512;5663.3665345612835;5689.459501347365;5729.570282228766;5385.946140538545;5484.588655850907;5509.586780991522;5546.75039623226;5564.527015203753;5482.506574408322;5490.5607551395;5495.697736624524;5567.777288908398;5608.588307028017;5206.5314121729225;5431.669241035971;5461.006732542673;5463.754131064032;5525.834224973257;5484.2596249505805;5513.255710479194;5527.170924361378;5551.555875529867;5555.638883472723;5412.864678383072;5440.265564148789;5441.374241962225;5474.616776825584;5487.807926722546 06:40:31 INFO - PROCESS | 27603 | |5;yui.html;688.7486067585331;712.4264966701804;724.4059870905857;735.7204262380295;782.0810547606561;14641.341139648715;15804.920975395122;15889.284982175786;15890.205489725526;15897.205139742995;13718.314084295795;13725.931370343134;13748.037637365389;13795.172289662602;13796.448142074305;659.8548319369755;673.8147009572382;781.6560713286165;786.866232740434;790.6481615681024;808.1675873849944;810.712197170005;811.342812322021;811.5293129984624;816.9836603267931;846.0101681033206;850.2517784349764;850.961706723199;851.0808327006848;851.3359579527978;684.4626967830229;685.338648204485;685.6400389795373;700.9193942696604;831.1646794971045;601.6330038676404;605.9060845568944;612.9662868542229;621.7792683597303;621.9004959206505;14070.92964535181;14073.5074272401;14090.084144530572;14106.858931410658;14116.15303081808;13459.66350841227;13942.23317717525;14507.1295722257;14630.122192668474;14731.631709207248;11404.429778511041;11405.37270450125;11498.367589782558;11687.298762074302;11716.53133874644;4118.402831589433;4173.5409104998425;4217.135487225111;4246.7027308088445;4287.356896465524;78011;79232;79584.60207698982;81741.62622205772;83142;10893.183011274186;11179.66461006171;11189.720256993478;11216.495257713423;11313.264637798517;20522.897385512977;21623.891880540497;21643.891780541;21679.241226556995;21682.56634867294;8216.356461332007;8350.123237060143;8403.453775504573;8692.782680432912;8731.694390696295;4821.9035619288115;4849;4883;4896.216605343128;4937.901391908425;3660.377735784923;3800.638939300762;3825.1202223488754;3826.1582451860545;3828.406596977473;703.391566295151;704.2359040441179;704.6723273677662;717.3830505765038;730.422965856967;642.3704769326087;643.0450780590819;680.2381332907077;696.2202333386538;734.8493558820536;9045.366824322366;9455.952720236355;9525.618975240914;9594.904050959542;9639.277054220822;671.278375746075;680.8025672555002;688.879446096931;702.817267510451;716.7992961970552;4128.483939507561;4620.607248383858;4664.603508701731;4693.577578017995;4765.03123632165;70707;71553.6422317885;72285.6385718068;104584.47707761565;118584;74583;101352.49323753334;103414.52196692469;104232;104490;88330.55834720786;89306;91399.08600914039;92228;92649;8647.524386158822;8911.287097032093;8930.553472326488;8960.85161418699;9028.232600229054;53426.1986070217;54002.72998634982;54127;54686.72656636692;56378.1543276843;73310.26689733034;73947.63026184835;82954.58522707589;83237.16762832536;84339;10853.837192441963;11101.94449027782;11947.940260298643;11992.280463172237;12124.09069319787;13344.733105338033;13395;13499.86500134986;13923.23422211788;14102.141351159755;12217.755644887231;12384;13124.753148450882;13127.934360328138;13777.862221378058;11669.416529173677;11773.587924422603;11856.525738970344;12114.21257618252;13107.737845243233;11874.228175168586;12119.878801211875;12304.200226985216;12344.876551234733;13313.068085234328;9659.178969787647;9836.114303832393;10145.391276523136;10200.28597998133;10587.947060264649;10055.052459408562;10114.393136411838;10185.541650625592;10201.18532436504;10295.53670084833 06:40:31 INFO - PROCESS | 27603 | __end_tp_report 06:40:31 INFO - PROCESS | 27603 | __start_cc_report 06:40:31 INFO - PROCESS | 27603 | _x_x_mozilla_cycle_collect,1374 06:40:31 INFO - PROCESS | 27603 | __end_cc_report 06:40:31 INFO - PROCESS | 27603 | __startTimestamp1475761231222__endTimestamp 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | ------- Summary: start ------- 06:40:31 INFO - PROCESS | 27603 | Number of tests: 6 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#0] dojo.html Cycles:165 Average:5196.59 Median:5413.32 stddev:574.62 (10.6%) stddev-sans-first:549.20 06:40:31 INFO - PROCESS | 27603 | Values: 2970.5 3008.2 3016.4 3023.7 3040.6 5116.5 5195.4 5214.1 5287.7 5293.0 5219.3 5230.8 5304.4 5347.5 5363.0 4731.1 4747.6 4757.7 4774.3 4869.6 4902.4 4924.5 4939.6 4943.3 4975.7 4679.4 4738.4 4738.5 4802.5 4813.0 4799.8 4803.9 4809.4 4812.4 4814.5 4723.5 4737.5 4744.6 4744.8 4747.0 5116.1 5176.6 5209.1 5220.4 5232.9 5487.4 5570.0 5578.3 5588.6 5590.6 5692.5 5693.4 5700.6 5702.2 5705.2 5073.1 5128.8 5224.1 5308.4 5375.2 5591.0 5611.6 5629.4 5630.8 5646.7 5408.7 5416.6 5418.9 5422.2 5427.4 5378.0 5435.8 5495.8 5495.9 5562.8 5533.9 5573.3 5582.7 5599.2 5600.0 5553.7 5556.0 5558.7 5609.4 5616.1 4294.2 4295.0 4301.1 4304.3 4349.2 3808.7 3828.8 3833.5 3866.3 3877.6 5311.6 5322.7 5396.3 5428.6 5431.3 5520.2 5551.2 5599.9 5603.7 5606.4 5170.7 5218.1 5313.9 5322.4 5371.6 4838.6 4883.3 4890.9 4919.7 4973.3 5795.7 5828.4 5831.2 5836.6 5860.8 5412.3 5626.1 5638.7 5642.4 5647.5 5654.0 5669.6 5714.2 5720.0 5817.3 5394.8 5430.0 5431.7 5442.9 5451.5 5455.5 5511.1 5512.6 5516.6 5585.5 5361.0 5416.7 5441.6 5483.6 5499.3 5492.4 5492.8 5496.5 5500.7 5542.9 5402.4 5414.8 5418.5 5422.5 5505.3 5413.3 5433.1 5446.8 5479.1 5525.7 5359.2 5362.6 5369.2 5421.9 5440.0 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#1] ext.html Cycles:180 Average:58367.58 Median:19845.60 stddev:115390.77 (581.4%) stddev-sans-first:115632.82 06:40:31 INFO - PROCESS | 27603 | Values: 549.5 587.0 589.2 595.2 617.5 30816.0 41700.2 42753.1 42779.8 46035.5 43651.8 44190.1 44192.6 44220.1 44262.3 8019.2 8234.4 8874.3 9002.0 9029.0 10404.2 10691.6 10698.3 11003.6 11004.6 10821.8 10920.9 10929.9 10930.8 10936.3 10397.2 10458.1 10465.8 10466.7 10473.2 10480.2 10521.5 10544.4 10551.5 10553.1 41995.8 42175.4 42320.0 42328.6 42333.6 3504.4 3520.2 3584.6 3644.1 3959.2 31400.5 31640.5 31668.8 31897.5 32075.8 4070.8 4155.1 4185.9 4214.9 4258.6 324365.0 327473.4 327583.0 327939.0 329084.0 56848.0 57131.7 57159.0 57290.0 57353.0 35784.8 36786.4 60078.0 60114.0 60195.4 15702.8 15951.0 15968.9 15973.0 15998.4 12020.3 12303.1 12712.4 13054.2 13092.3 18069.7 18748.3 18769.7 18851.5 19078.7 6673.8 6914.8 7053.6 7086.3 7184.5 904.4 991.4 1022.3 1024.6 1035.9 31198.4 31609.5 31965.7 32180.0 32598.5 1042.3 1068.7 1085.2 1112.9 1160.2 15197.7 16572.6 16663.8 16755.7 16782.7 542581.7 545753.0 546456.0 547178.0 547977.0 56629.7 57158.4 57168.0 57246.7 57385.3 1229.6 1235.5 1266.8 1308.4 1369.0 29950.6 32511.2 32586.2 32625.8 32629.5 47958.5 48541.0 48550.8 48578.5 48663.3 400035.0 403462.0 404231.0 404678.2 405456.7 27260.5 27801.3 28320.8 28457.9 29540.0 45672.3 45862.0 46385.5 46772.0 47049.3 37331.0 37614.8 37622.8 37756.4 39376.0 37423.3 37767.4 38873.0 38986.4 39473.6 38970.2 39205.6 39885.2 40500.6 42761.4 33642.3 35692.0 35724.3 36106.6 36885.8 27301.0 27512.7 27553.2 27711.4 27711.9 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#2] jquery.html Cycles:180 Average:25016.95 Median:401.07 stddev:64567.38 (16098.8%) stddev-sans-first:64722.01 06:40:31 INFO - PROCESS | 27603 | Values: 382.4 389.4 397.6 404.6 419.9 13215.4 15070.8 18824.7 18928.7 19516.0 18072.0 18083.8 18503.4 18604.9 18637.4 5661.2 5675.7 5907.1 5907.4 5911.6 5398.8 5881.4 5908.6 5910.7 5917.2 5712.8 5748.4 5870.4 5877.6 5881.6 5770.7 5792.0 5834.2 5838.6 5839.1 5022.6 5137.5 5216.6 5247.3 5252.0 22375.2 22715.2 23042.9 23070.2 23255.7 2167.3 2218.8 2513.3 2533.6 2806.6 13926.7 14067.0 14175.5 14543.2 14580.5 1792.1 1869.5 1870.9 1872.1 1883.7 47528.0 47970.8 56028.0 68959.3 71551.0 9372.2 10157.2 10462.2 10478.9 10537.5 12206.5 13080.4 13127.4 13458.2 13716.9 7105.0 7215.1 7717.3 8201.9 8229.9 7918.7 8074.5 8182.8 8350.1 8352.0 4770.4 4782.7 4803.4 4809.7 4908.2 1967.2 1979.3 2027.4 2061.8 2063.6 841.7 920.7 939.7 949.5 1004.3 17271.7 17599.9 18401.6 18747.3 18861.5 939.6 953.0 955.5 960.6 1025.3 10036.1 10118.6 10454.7 10521.6 10540.3 384390.0 384396.0 384600.0 384857.0 411482.0 89101.1 90916.5 91469.5 91510.0 93432.5 948.1 959.5 968.4 968.9 972.1 15785.0 15936.0 16302.7 16518.7 16648.2 28362.9 36986.6 41280.6 41993.6 42225.8 47721.5 53950.7 54480.2 55823.4 56732.1 8230.6 8420.9 8446.4 8559.3 8743.0 10109.4 11631.6 11945.7 12227.0 12652.3 9799.9 9870.3 10140.5 10644.3 10706.3 10019.6 10341.9 10481.2 10582.5 10694.9 9578.7 9930.8 10058.9 10368.1 10810.0 8226.4 8293.9 8329.9 8342.0 8567.5 10064.7 10216.6 10276.5 10439.9 10529.5 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#3] mootools.html Cycles:180 Average:5814.66 Median:4879.21 stddev:3324.64 (68.1%) stddev-sans-first:3317.35 06:40:31 INFO - PROCESS | 27603 | Values: 1392.6 1443.6 1535.8 1780.2 1780.6 7948.1 8125.0 8729.9 9181.3 9191.8 8095.6 8363.9 8400.0 8648.1 8673.7 2319.9 2339.1 2350.0 2352.1 2358.1 2009.8 2075.5 2282.4 2290.3 2343.6 2237.1 2285.4 2306.0 2330.0 2337.3 2320.5 2357.7 2362.6 2368.2 2368.7 2314.8 2327.1 2333.9 2335.4 2335.9 9053.7 9082.8 9089.2 9155.1 9158.0 5172.7 5228.5 5270.4 5310.7 5314.2 3313.9 3384.9 3467.7 3475.8 3478.3 1100.7 1138.0 1145.7 1170.2 1173.3 12122.3 12206.8 12219.8 12227.6 12228.6 4421.4 4727.8 4764.3 4817.9 4857.6 10249.0 10253.2 10256.4 10260.9 10269.8 5369.7 5378.8 5382.3 5384.5 5385.0 4813.0 4900.8 4955.0 4956.2 4958.7 3768.6 3814.7 3840.8 3847.1 3917.6 1039.7 1061.3 1112.2 1142.4 1156.4 826.9 894.4 905.7 906.9 914.8 5658.3 5774.0 5809.2 5864.5 5868.2 912.6 919.7 933.0 937.8 966.2 3811.9 3915.9 3973.5 4085.4 4106.1 10692.9 10795.2 10944.0 10960.2 10962.2 10617.8 10786.4 10852.5 10909.6 10915.9 8268.3 8443.4 8512.2 8514.1 8519.7 5959.2 5974.3 5998.1 6063.9 6271.2 10076.4 10217.2 10483.6 10490.3 10586.7 10446.6 10558.7 10629.5 10672.7 10709.6 7819.7 7992.0 8079.5 8134.3 8151.0 8224.5 8358.7 8452.2 8462.7 8484.4 7388.8 7695.3 7708.8 7798.5 7819.6 7402.7 7443.4 7602.6 7681.1 7830.1 6976.8 6995.3 7028.8 7044.2 7049.5 4995.5 5037.2 5118.7 5151.5 5187.9 5072.6 5179.6 5249.6 5258.8 5261.7 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#4] prototype.html Cycles:180 Average:4524.98 Median:4939.27 stddev:1285.59 (26.0%) stddev-sans-first:1250.16 06:40:31 INFO - PROCESS | 27603 | Values: 336.3 347.2 351.6 356.9 360.5 5167.7 5280.1 5331.3 5409.1 5436.5 5129.3 5217.8 5221.4 5248.5 5255.1 4169.0 4170.0 4176.6 4187.4 4259.9 4019.4 4183.5 4233.8 4272.9 4273.1 4170.1 4182.8 4183.5 4186.7 4209.2 4167.9 4173.2 4174.4 4193.7 4207.6 3780.7 3784.2 3787.2 3788.4 3804.2 5060.8 5112.5 5119.7 5137.5 5210.6 4785.5 4786.7 4790.3 4791.1 4805.3 5431.5 5487.3 5494.9 5497.8 5538.0 4040.2 4044.6 4074.1 4082.6 4085.3 5601.7 5631.5 5641.4 5660.9 5669.7 4156.2 4189.2 4199.2 4228.7 4239.9 4168.8 4253.2 4267.9 4269.4 4272.1 4736.6 4744.4 4751.2 4755.3 4760.6 5483.2 5510.5 5513.1 5513.5 5544.7 1353.6 1360.8 1449.7 1460.4 1468.7 939.3 939.9 965.3 968.8 974.4 4677.9 4691.0 4704.7 4711.5 4721.0 4875.8 4890.5 4911.6 4984.3 4988.6 4520.8 4696.2 4719.6 4762.0 4767.5 2621.1 2631.4 2633.6 2640.2 2672.4 5072.0 5115.9 5152.9 5164.3 5164.9 4694.6 4932.9 4964.5 5009.5 5030.6 5019.7 5070.9 5086.5 5095.8 5148.6 4886.8 4921.2 4924.7 4939.8 4985.7 4868.0 4937.5 4938.8 5259.9 5678.9 5778.7 5893.9 5949.3 5951.9 5960.2 4084.4 4130.5 4138.4 4150.9 4154.3 5409.6 5602.2 5663.4 5689.5 5729.6 5385.9 5484.6 5509.6 5546.8 5564.5 5482.5 5490.6 5495.7 5567.8 5608.6 5206.5 5431.7 5461.0 5463.8 5525.8 5484.3 5513.3 5527.2 5551.6 5555.6 5412.9 5440.3 5441.4 5474.6 5487.8 06:40:31 INFO - PROCESS | 27603 | 06:40:31 INFO - PROCESS | 27603 | [#5] yui.html Cycles:180 Average:20166.00 Median:4866.00 stddev:28943.48 (594.8%) stddev-sans-first:28987.72 06:40:31 INFO - PROCESS | 27603 | Values: 688.7 712.4 724.4 735.7 782.1 14641.3 15804.9 15889.3 15890.2 15897.2 13718.3 13725.9 13748.0 13795.2 13796.4 659.9 673.8 781.7 786.9 790.6 808.2 810.7 811.3 811.5 817.0 846.0 850.3 851.0 851.1 851.3 684.5 685.3 685.6 700.9 831.2 601.6 605.9 613.0 621.8 621.9 14070.9 14073.5 14090.1 14106.9 14116.2 13459.7 13942.2 14507.1 14630.1 14731.6 11404.4 11405.4 11498.4 11687.3 11716.5 4118.4 4173.5 4217.1 4246.7 4287.4 78011.0 79232.0 79584.6 81741.6 83142.0 10893.2 11179.7 11189.7 11216.5 11313.3 20522.9 21623.9 21643.9 21679.2 21682.6 8216.4 8350.1 8403.5 8692.8 8731.7 4821.9 4849.0 4883.0 4896.2 4937.9 3660.4 3800.6 3825.1 3826.2 3828.4 703.4 704.2 704.7 717.4 730.4 642.4 643.0 680.2 696.2 734.8 9045.4 9456.0 9525.6 9594.9 9639.3 671.3 680.8 688.9 702.8 716.8 4128.5 4620.6 4664.6 4693.6 4765.0 70707.0 71553.6 72285.6 104584.5 118584.0 74583.0 101352.5 103414.5 104232.0 104490.0 88330.6 89306.0 91399.1 92228.0 92649.0 8647.5 8911.3 8930.6 8960.9 9028.2 53426.2 54002.7 54127.0 54686.7 56378.2 73310.3 73947.6 82954.6 83237.2 84339.0 10853.8 11101.9 11947.9 11992.3 12124.1 13344.7 13395.0 13499.9 13923.2 14102.1 12217.8 12384.0 13124.8 13127.9 13777.9 11669.4 11773.6 11856.5 12114.2 13107.7 11874.2 12119.9 12304.2 12344.9 13313.1 9659.2 9836.1 10145.4 10200.3 10587.9 10055.1 10114.4 10185.5 10201.2 10295.5 06:40:31 INFO - PROCESS | 27603 | -------- Summary: end -------- 06:40:31 INFO - PROCESS | 27603 | 06:40:32 INFO - TEST-INFO | 27603: exit 0 06:40:32 INFO - TEST-OK | dromaeo_css | took 1117502ms 06:40:32 INFO - TEST-START | kraken 06:40:32 INFO - operating with platform_type : linux_ 06:40:32 INFO - Initialising browser for kraken test... 06:40:32 INFO - TEST-INFO | started process 27909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeNy8x/profile http://localhost:50597/getInfo.html) 06:40:36 INFO - PROCESS | 27909 | __metrics Screen width/height:1600/1200 06:40:36 INFO - PROCESS | 27909 | colorDepth:24 06:40:36 INFO - PROCESS | 27909 | Browser inner width/height: 1024/697 06:40:36 INFO - PROCESS | 27909 | __metrics 06:40:37 INFO - PROCESS | 27909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:40:37 INFO - PROCESS | 27909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:40:37 INFO - PROCESS | 27909 | console.error: PushService: 06:40:37 INFO - PROCESS | 27909 | stateChangeProcessEnqueue: Error transitioning state 06:40:37 INFO - PROCESS | 27909 | UnknownError 06:40:38 INFO - TEST-INFO | 27909: exit 0 06:40:38 INFO - Browser initialized. 06:40:38 INFO - Running cycle 1/1 for kraken test... 06:40:38 INFO - TEST-INFO | started process 27991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeNy8x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:50 INFO - PROCESS | 27991 | RSS: Main: 173539328 06:40:50 INFO - PROCESS | 27991 | 06:40:53 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:53 INFO - PROCESS | 27991 | RSS: Main: 233160704 06:40:53 INFO - PROCESS | 27991 | 06:40:56 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-dft) 06:40:57 INFO - PROCESS | 27991 | RSS: Main: 218398720 06:40:57 INFO - PROCESS | 27991 | 06:41:00 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-fft) 06:41:00 INFO - PROCESS | 27991 | RSS: Main: 299794432 06:41:00 INFO - PROCESS | 27991 | 06:41:03 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-oscillator) 06:41:03 INFO - PROCESS | 27991 | RSS: Main: 208683008 06:41:03 INFO - PROCESS | 27991 | 06:41:05 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:06 INFO - PROCESS | 27991 | RSS: Main: 213557248 06:41:06 INFO - PROCESS | 27991 | 06:41:09 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:09 INFO - PROCESS | 27991 | RSS: Main: 249815040 06:41:09 INFO - PROCESS | 27991 | 06:41:13 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:13 INFO - PROCESS | 27991 | RSS: Main: 248442880 06:41:13 INFO - PROCESS | 27991 | 06:41:16 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50597/tests/kraken/driver.html?testName=json-parse-financial) 06:41:17 INFO - PROCESS | 27991 | RSS: Main: 248926208 06:41:17 INFO - PROCESS | 27991 | 06:41:18 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:19 INFO - PROCESS | 27991 | RSS: Main: 211361792 06:41:19 INFO - PROCESS | 27991 | 06:41:21 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:21 INFO - PROCESS | 27991 | RSS: Main: 218058752 06:41:21 INFO - PROCESS | 27991 | 06:41:23 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:24 INFO - PROCESS | 27991 | RSS: Main: 228220928 06:41:24 INFO - PROCESS | 27991 | 06:41:27 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:27 INFO - PROCESS | 27991 | RSS: Main: 232022016 06:41:27 INFO - PROCESS | 27991 | 06:41:30 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:31 INFO - PROCESS | 27991 | RSS: Main: 233594880 06:41:31 INFO - PROCESS | 27991 | 06:41:32 INFO - PROCESS | 27991 | Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50597/tests/kraken/driver.html?testName=ai-astar) 06:41:33 INFO - PROCESS | 27991 | RSS: Main: 284577792 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | __start_tp_report 06:41:33 INFO - PROCESS | 27991 | _x_x_mozilla_page_load 06:41:33 INFO - PROCESS | 27991 | _x_x_mozilla_page_load_details 06:41:33 INFO - PROCESS | 27991 | |i|pagename|runs| 06:41:33 INFO - PROCESS | 27991 | |0;ai-astar;109;111;110;111;112;111;111;109;110;110 06:41:33 INFO - PROCESS | 27991 | |1;audio-beat-detection;149;121;126;182;122;123;121;120;163;128 06:41:33 INFO - PROCESS | 27991 | |2;audio-dft;162;162;161;162;161;162;164;163;162;161 06:41:33 INFO - PROCESS | 27991 | |3;audio-fft;75;76;76;118;77;75;76;75;108;77 06:41:33 INFO - PROCESS | 27991 | |4;audio-oscillator;82;83;115;84;83;84;101;82;81;114 06:41:33 INFO - PROCESS | 27991 | |5;imaging-gaussian-blur;116;116;116;117;116;117;117;117;117;118 06:41:33 INFO - PROCESS | 27991 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;146;145 06:41:33 INFO - PROCESS | 27991 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 06:41:33 INFO - PROCESS | 27991 | |8;json-parse-financial;52;54;53;50;51;53;53;52;52;54 06:41:33 INFO - PROCESS | 27991 | |9;json-stringify-tinderbox;60;61;61;62;61;61;60;61;61;62 06:41:33 INFO - PROCESS | 27991 | |10;stanford-crypto-aes;81;79;79;80;85;80;79;87;79;80 06:41:33 INFO - PROCESS | 27991 | |11;stanford-crypto-ccm;153;140;138;139;140;129;138;134;203;130 06:41:33 INFO - PROCESS | 27991 | |12;stanford-crypto-pbkdf2;166;171;164;166;165;173;166;168;170;168 06:41:33 INFO - PROCESS | 27991 | |13;stanford-crypto-sha256-iterative;70;66;66;66;67;67;69;65;67;65 06:41:33 INFO - PROCESS | 27991 | __end_tp_report 06:41:33 INFO - PROCESS | 27991 | __start_cc_report 06:41:33 INFO - PROCESS | 27991 | _x_x_mozilla_cycle_collect,1611 06:41:33 INFO - PROCESS | 27991 | __end_cc_report 06:41:33 INFO - PROCESS | 27991 | __startTimestamp1475761293172__endTimestamp 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | ------- Summary: start ------- 06:41:33 INFO - PROCESS | 27991 | Number of tests: 14 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 06:41:33 INFO - PROCESS | 27991 | Values: 109.0 111.0 110.0 111.0 112.0 111.0 111.0 109.0 110.0 110.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:127.00 stddev:21.72 (17.1%) stddev-sans-first:22.48 06:41:33 INFO - PROCESS | 27991 | Values: 149.0 121.0 126.0 182.0 122.0 123.0 121.0 120.0 163.0 128.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 06:41:33 INFO - PROCESS | 27991 | Values: 162.0 162.0 161.0 162.0 161.0 162.0 164.0 163.0 162.0 161.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.85 (20.9%) stddev-sans-first:16.52 06:41:33 INFO - PROCESS | 27991 | Values: 75.0 76.0 76.0 118.0 77.0 75.0 76.0 75.0 108.0 77.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.50 stddev:13.71 (16.6%) stddev-sans-first:14.16 06:41:33 INFO - PROCESS | 27991 | Values: 82.0 83.0 115.0 84.0 83.0 84.0 101.0 82.0 81.0 114.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 06:41:33 INFO - PROCESS | 27991 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:41:33 INFO - PROCESS | 27991 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:41:33 INFO - PROCESS | 27991 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.33 06:41:33 INFO - PROCESS | 27991 | Values: 52.0 54.0 53.0 50.0 51.0 53.0 53.0 52.0 52.0 54.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 06:41:33 INFO - PROCESS | 27991 | Values: 60.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 62.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.81 (3.5%) stddev-sans-first:2.98 06:41:33 INFO - PROCESS | 27991 | Values: 81.0 79.0 79.0 80.0 85.0 80.0 79.0 87.0 79.0 80.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:139.50 stddev:21.63 (15.5%) stddev-sans-first:22.72 06:41:33 INFO - PROCESS | 27991 | Values: 153.0 140.0 138.0 139.0 140.0 129.0 138.0 134.0 203.0 130.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:2.87 (1.7%) stddev-sans-first:2.98 06:41:33 INFO - PROCESS | 27991 | Values: 166.0 171.0 164.0 166.0 165.0 173.0 166.0 168.0 170.0 168.0 06:41:33 INFO - PROCESS | 27991 | 06:41:33 INFO - PROCESS | 27991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.24 06:41:33 INFO - PROCESS | 27991 | Values: 70.0 66.0 66.0 66.0 67.0 67.0 69.0 65.0 67.0 65.0 06:41:33 INFO - PROCESS | 27991 | -------- Summary: end -------- 06:41:33 INFO - PROCESS | 27991 | 06:41:34 INFO - TEST-INFO | 27991: exit 0 06:41:34 INFO - TEST-OK | kraken | took 62253ms 06:41:34 INFO - SUITE-END | took 1179s 06:41:34 INFO - Completed test suite (00:19:40) 06:41:34 INFO - javascript benchmark 06:41:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2970.5395663672125, 3008.18778929689, 3016.381641763439, 3023.6673965863765, 3040.5591189277548, 5116.539511443969, 5195.350581177353, 5214.061468935595, 5287.682739035656, 5293.047251494734, 5219.321488206538, 5230.816921407752, 5304.3634763828295, 5347.465253474651, 5363.0, 4731.077439899221, 4747.643926705511, 4757.738324392157, 4774.28385742138, 4869.634777391692, 4902.3872015998, 4924.507549245065, 4939.555440010398, 4943.332650092228, 4975.701457912519, 4679.415073115861, 4738.384010078702, 4738.47876733559, 4802.543758342969, 4813.013332266877, 4799.832005879813, 4803.879903002418, 4809.446913604946, 4812.446568644581, 4814.518548145193, 4723.504032076617, 4737.526247375269, 4744.6441516886025, 4744.810207591692, 4747.026859493795, 5116.104681680691, 5176.5858731301405, 5209.114450543417, 5220.373555173365, 5232.947670523284, 5487.42382049883, 5569.972150139264, 5578.30271216098, 5588.608797384185, 5590.580706447033, 5692.516136128393, 5693.430656934315, 5700.600957932947, 5702.201691763156, 5705.1727499512335, 5073.086844367976, 5128.79484820603, 5224.111900976843, 5308.416074231832, 5375.16684913839, 5590.993621148233, 5611.6071874969175, 5629.380768115504, 5630.8029218977135, 5646.745896434671, 5408.675479471244, 5416.647917885325, 5418.945810541923, 5422.15956526739, 5427.43011983744, 5378.0, 5435.809746658927, 5495.835124946258, 5495.945040549544, 5562.833115006556, 5533.944660553423, 5573.331200255995, 5582.692951887685, 5599.216109744558, 5599.972000139973, 5553.694546799884, 5556.0, 5558.694271815089, 5609.354924183689, 5616.073347897551, 4294.205571969195, 4294.9785251073545, 4301.118270754488, 4304.289792184254, 4349.151915376471, 3808.6762625176616, 3828.8277027533827, 3833.4824798652385, 3866.3233934061427, 3877.6122387760997, 5311.575073994071, 5322.680639161663, 5396.298481197419, 5428.565714742811, 5431.266778984866, 5520.199571062173, 5551.195076713854, 5599.8600034998635, 5603.691796951207, 5606.439356064361, 5170.663906846043, 5218.08683480397, 5313.946860531422, 5322.441143679858, 5371.57027437804, 4838.588719958843, 4883.34074899891, 4890.926636100461, 4919.704817710877, 4973.303737476756, 5795.710214489343, 5828.358880523224, 5831.212786273799, 5836.649801011868, 5860.824175274749, 5412.323459567554, 5626.071698169756, 5638.661680299195, 5642.379338272704, 5647.463490968352, 5654.0, 5669.574781891292, 5714.228579141763, 5720.027595308724, 5817.331006934088, 5394.838154855361, 5430.049741295336, 5431.701256430934, 5442.8639284016635, 5451.509364157245, 5455.536279416136, 5511.118221084607, 5512.641678290898, 5516.613837031369, 5585.497305242548, 5360.973195133999, 5416.674999500043, 5441.564674826083, 5483.561315094863, 5499.285092938053, 5492.395836457907, 5492.780288788404, 5496.5053145217125, 5500.669959802424, 5542.889142217214, 5402.35171779389, 5414.83755487336, 5418.539424148991, 5422.539084177889, 5505.284313039279, 5413.323334583177, 5433.103537916358, 5446.836594902159, 5479.0959491683425, 5525.723713814374, 5359.169328754049, 5362.570994320367, 5369.248305237348, 5421.945780542144, 5439.972800135974], "value": 5158.351968967723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5230785025985, 586.9589128760987, 589.1839801874403, 595.2172892646173, 617.4689766800551, 30816.0, 41700.16599668009, 42753.14493710124, 42779.786101069454, 46035.539644603545, 43651.78174109133, 44190.11619767603, 44192.55807441925, 44220.115597688025, 44262.336064959054, 8019.157988411221, 8234.382421318425, 8874.334424918141, 9002.0, 9029.0, 10404.167666586654, 10691.625793097242, 10698.251122421434, 11003.61487347943, 11004.559817607325, 10821.783564328709, 10920.945395273013, 10929.923314570206, 10930.781384372307, 10936.289141205836, 10397.168226541897, 10458.111060559824, 10465.790684186273, 10466.685999419953, 10473.162147028219, 10480.161587073017, 10521.52653130611, 10544.420056896868, 10551.525181366856, 10553.050225479743, 41995.79002105001, 42175.36736948948, 42320.0, 42328.576714232775, 42333.576664233275, 3504.3867323218333, 3520.1727594015388, 3584.5698516178227, 3644.1254099016046, 3959.208158368309, 31400.528992065138, 31640.525392119136, 31668.841655791803, 31897.52153717696, 32075.839620801748, 4070.796460177009, 4155.10665206982, 4185.937210941838, 4214.936775948363, 4258.574142585748, 324365.0, 327473.3626331877, 327583.0, 327939.0, 329084.0, 56848.0, 57131.71434142803, 57159.0, 57290.0, 57353.0, 35784.821075894455, 36786.448203276974, 60078.0, 60114.0, 60195.39804601986, 15702.842971570139, 15951.0, 15968.92015539938, 15973.041617502988, 15998.360065597246, 12020.338881361435, 12303.138780285473, 12712.42794074269, 13054.216746995211, 13092.345382730826, 18069.7289540657, 18748.25006999732, 18769.7184542232, 18851.528711782314, 19078.713819292723, 6673.799786006428, 6914.7872680742685, 7053.647317634098, 7086.326798954195, 7184.533005354635, 904.4482865452069, 991.4051569058507, 1022.325265324882, 1024.5799222318813, 1035.8549803027581, 31198.376032479224, 31609.525857112163, 31965.680343196735, 32180.0, 32598.511022334686, 1042.3172821801732, 1068.738159151013, 1085.1590017736316, 1112.933224006562, 1160.22265082395, 15197.696046079238, 16572.58568535796, 16663.833361666228, 16755.664886702198, 16782.74825877613, 542581.7225483241, 545753.0, 546456.0, 547178.0, 547977.0, 56629.716851416306, 57158.42841571531, 57168.0, 57246.713766431734, 57385.26995745346, 1229.6065259117177, 1235.5490246060124, 1266.7593157300084, 1308.378520202896, 1368.9540771782704, 29950.550741739327, 32511.18722031968, 32586.185345366557, 32625.836870815496, 32629.510557342135, 47958.5204147968, 48541.0, 48550.75724621354, 48578.5142148574, 48663.27005094997, 400035.0, 403462.0, 404231.0, 404678.22809237323, 405456.69988150935, 27260.454790903674, 27801.304967375978, 28320.751887217084, 28457.857710711312, 29540.0, 45672.31491527563, 45862.0, 46385.536144639475, 46772.0, 47049.2942605868, 37331.0, 37614.811925940194, 37622.8118859404, 37756.43365349577, 39376.0, 37423.31288343554, 37767.433488498245, 38873.0, 38986.415203772536, 39473.60526394814, 38970.2205955885, 39205.60794392019, 39885.202295953335, 40500.59499404968, 42761.358579621956, 33642.327153457285, 35692.0, 35724.28551429009, 36106.63893361033, 36885.81557092305, 27301.0, 27512.724872751016, 27553.17340479789, 27711.44577108487, 27711.861440692668], "value": 19968.33952593125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.3614563678656, 389.36922186058587, 397.57260944484676, 404.5671131888879, 419.897125204325, 13215.405306761195, 15070.849291507082, 18824.717629235554, 18928.71606925897, 19516.0, 18072.0, 18083.819161808377, 18503.444896653087, 18604.906975465103, 18637.440876773686, 5661.179129026299, 5675.6878371689545, 5907.143464197688, 5907.379725128864, 5911.645301281937, 5398.78404863805, 5881.4118588141055, 5908.645481271116, 5910.729193223456, 5917.171595976567, 5712.828615141552, 5748.396418376073, 5870.354261031304, 5877.559183061266, 5881.617694849821, 5770.740316685738, 5792.0, 5834.212381328509, 5838.620489668179, 5839.065749480063, 5022.6233032522705, 5137.537621614073, 5216.58267338612, 5247.317848679685, 5251.973740131313, 22375.216867409727, 22715.204967826212, 23042.884785576134, 23070.192543260906, 23255.651165232535, 2167.2847960173103, 2218.8442273667456, 2513.258588716333, 2533.607290869918, 2806.564982427727, 13926.651833704138, 14067.0, 14175.503857364944, 14543.200123993176, 14580.489682861049, 1792.1218602884624, 1869.4672018474669, 1870.8690391672587, 1872.101391332168, 1883.6986082226779, 47528.0, 47970.76014619905, 56028.0, 68959.31040689579, 71551.0, 9372.1565059145, 10157.238207134495, 10462.215333849992, 10478.895211047791, 10537.473126343806, 12206.511739530497, 13080.411381487856, 13127.409266583027, 13458.192508449329, 13716.931415342859, 7105.0, 7215.134183897861, 7717.2668596483245, 8201.917980820235, 8229.917700822914, 7918.683252669829, 8074.475159114756, 8182.7545173644885, 8350.117195504119, 8352.0, 4770.379850619397, 4782.713037217778, 4803.430164861852, 4809.677338731807, 4908.165611845995, 1967.1639553189837, 1979.3171355882198, 2027.3917824652544, 2061.814436700704, 2063.6388631989344, 841.6801615386237, 920.6685593186447, 939.7313626604166, 949.4540639132526, 1004.3371374892536, 17271.7409238859, 17599.91200044017, 18401.631967360845, 18747.25010999572, 18861.52846178829, 939.6241503398695, 952.9666461673808, 955.5222388805597, 960.6397600899662, 1025.266934142092, 10036.146927511098, 10118.595256189818, 10454.693163354581, 10521.579136834594, 10540.314879532805, 384390.0, 384396.0, 384600.0, 384857.0, 411482.0, 89101.09943953145, 90916.54541727249, 91469.54265228631, 91510.0, 93432.53283733538, 948.1229862377273, 959.52023988006, 968.4479846487575, 968.8885778135605, 972.1445128287204, 15785.0, 15936.0, 16302.67394652124, 16518.678505719272, 16648.16759162061, 28362.85818570894, 36986.63013369939, 41280.58719412888, 41993.58006419897, 42225.78887105545, 47721.52278477171, 53950.73024634852, 54480.193565158654, 55823.441765581825, 56732.14901776394, 8230.588470576567, 8420.87368689458, 8446.366522510714, 8559.272461840814, 8743.0, 10109.443980580845, 11631.59289424866, 11945.701357466132, 12227.0, 12652.304123273309, 9799.902000979899, 9870.259730520096, 10140.49297535135, 10644.308119972176, 10706.304090234109, 10019.649312274036, 10341.9482902585, 10481.213908957012, 10582.523786429783, 10694.89305106939, 9578.664746733832, 9930.751731206778, 10058.899411005796, 10368.066873981377, 10810.027097561257, 8226.424150309422, 8293.917060829315, 8329.875051874105, 8342.0, 8567.528785916835, 10064.69805905824, 10216.642417515352, 10276.537555809857, 10439.895601044196, 10529.4735263235], "value": 8785.47088351074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.5822253324004, 1443.6246575890268, 1535.8310585835557, 1780.2167046499546, 1780.5815633326174, 7948.085970113439, 8125.0, 8729.91270087299, 9181.311401644878, 9191.770205744851, 8095.635696393661, 8363.91636083639, 8399.958000210007, 8648.135186481364, 8673.73978780636, 2319.8840057997077, 2339.099446713011, 2349.95300093998, 2352.1179557665873, 2358.103920510204, 2009.788972157917, 2075.533005073861, 2282.4065742906796, 2290.3129061281634, 2343.60158773009, 2237.1163390460756, 2285.382946604416, 2306.042992158261, 2330.021391015769, 2337.333859849943, 2320.524292520029, 2357.71707395112, 2362.586547354215, 2368.230325144335, 2368.7157541095007, 2314.7685231476885, 2327.0924339507606, 2333.9183128590416, 2335.4394945213025, 2335.94160145996, 9053.68312109073, 9082.818343633156, 9089.181973622406, 9155.084491550859, 9158.038405967343, 5172.689638621657, 5228.4510126436935, 5270.39390470097, 5310.681359118426, 5314.176302673053, 3313.9005829825146, 3384.9323013539592, 3467.7056796043858, 3475.8088305143206, 3478.286951175003, 1100.6808025672544, 1137.994310028453, 1145.6792098212513, 1170.1867202294409, 1173.266708307308, 12122.333271670055, 12206.755864882742, 12219.816702749466, 12227.633171004794, 12228.633141005696, 4421.425214722066, 4727.763611819395, 4764.285357196448, 4817.855464336076, 4857.611391088704, 10249.0, 10253.231007674454, 10256.38461692301, 10260.948695256477, 10269.845952310572, 5369.704666243394, 5378.757955891994, 5382.273393091961, 5384.515393614593, 5384.973075134678, 4812.975935120372, 4900.803967841318, 4954.950450495521, 4956.157453232959, 4958.677685950402, 3768.6419790119894, 3814.7329686922203, 3840.8271627776817, 3847.1343947611563, 3917.6278253565865, 1039.740064983754, 1061.3048453263125, 1112.232559533919, 1142.3888219802366, 1156.4275683536703, 826.900771907375, 894.3828758156851, 905.7282815155559, 906.8866391701038, 914.7804526913626, 5658.292713410824, 5774.047282198474, 5809.244798176294, 5864.530837532987, 5868.237129173265, 912.5619702542816, 919.7240827751648, 932.9766755831158, 937.803061357109, 966.2221911361281, 3811.923761524754, 3915.882523524299, 3973.48344715191, 4085.387191921176, 4106.07613287008, 10692.893071069346, 10795.190360722978, 10944.0, 10960.232783705223, 10962.232643714864, 10617.84073238902, 10786.406747628798, 10852.457377131112, 10909.563617455213, 10915.945420272848, 8268.338532917352, 8443.408961372645, 8512.191341822518, 8514.14858514156, 8519.701810436605, 5959.195508606283, 5974.2830860297045, 5998.1002849572915, 6063.909041364472, 6271.150010746932, 10076.395416275047, 10217.182625389802, 10483.633072842718, 10490.265681402228, 10586.735331616772, 10446.582136714447, 10558.683239502827, 10629.521671524646, 10672.733181670521, 10709.625163119254, 7819.726309579138, 7991.960040199761, 8079.515229086273, 8134.308583770209, 8151.0, 8224.547649879314, 8358.665653373797, 8452.1547845215, 8462.746117616482, 8484.448510846774, 7388.778336649909, 7695.345895598937, 7708.807279818049, 7798.493097948615, 7819.569923654253, 7402.7409040683315, 7443.36731377839, 7602.6198690066385, 7681.078270607562, 7830.09953855314, 6976.825579360557, 6995.321122930562, 7028.824279393056, 7044.189918159477, 7049.471289653194, 4995.549455740728, 5037.219231019198, 5118.74406279692, 5151.5363617274625, 5187.870303242449, 5072.59419246452, 5179.585633149414, 5249.580033597379, 5258.789648414174, 5261.684298942076], "value": 4623.616851755348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.32231054425336, 347.1910448654635, 351.5605493133583, 356.88579654510534, 360.457511445275, 5167.689938603687, 5280.128778751501, 5331.320634000287, 5409.079776679281, 5436.483534064262, 5129.2562578426105, 5217.843464696056, 5221.373435187773, 5248.501392367729, 5255.1329030709885, 4169.0, 4170.040081161865, 4176.561461046592, 4187.413762073312, 4259.914801703964, 4019.437278780973, 4183.518895327031, 4233.788310584474, 4272.9359059614135, 4273.145370925828, 4170.124273902484, 4182.811773470186, 4183.477065366829, 4186.685998550106, 4209.221294060593, 4167.937480937803, 4173.165366926627, 4174.436451079096, 4193.6645068394455, 4207.600277973587, 3780.716446266541, 3784.1674831537016, 3787.223619158066, 3788.408868275331, 3804.2201348723447, 5060.7722652480725, 5112.472394048095, 5119.66722163062, 5137.460566640524, 5210.583153347723, 4785.521447855222, 4786.712797232177, 4790.299443697472, 4791.113643975876, 4805.303231031481, 5431.533485958769, 5487.29893732944, 5494.917576236359, 5497.8075767348355, 5538.0031594313, 4040.2121586290687, 4044.6359827615656, 4074.103697186614, 4082.6121518455698, 4085.3259212229946, 5601.747921343549, 5631.493165615073, 5641.379448260688, 5660.915086273709, 5669.716514174274, 4156.189543039079, 4189.183109293719, 4199.2441360555395, 4228.682848786353, 4239.936400953989, 4168.7707176105605, 4253.214144735203, 4267.871963841089, 4269.402283680287, 4272.124214536013, 4736.573708366263, 4744.3595114659765, 4751.192297309397, 4755.334253204554, 4760.64295177863, 5483.177523371526, 5510.531604813636, 5513.117901135879, 5513.476219759116, 5544.722763861791, 1353.5600929697691, 1360.7890776929592, 1449.6520834999524, 1460.3574427251974, 1468.6989167220695, 939.3424602777947, 939.9436033837854, 965.3001573859036, 968.7868668892833, 974.3666616699202, 4677.859664210079, 4690.9765451172525, 4704.69419487739, 4711.458182309078, 4720.952790472052, 4875.780589873464, 4890.508394939507, 4911.575643063543, 4984.327115839388, 4988.625853061035, 4520.773961301922, 4696.178168820443, 4719.575238228507, 4761.976190119097, 4767.547083027107, 2621.0564196889104, 2631.3947792007943, 2633.565461698798, 2640.231045199721, 2672.4387878545335, 5072.0109578632555, 5115.923261151086, 5152.861562451616, 5164.32863727713, 5164.870878228075, 4694.574352296875, 4932.8520144395725, 4964.503549645079, 5009.472111006178, 5030.560178313515, 5019.698818070928, 5070.898582028339, 5086.516780905734, 5095.8214264302915, 5148.588112950955, 4886.828960986349, 4921.163402221702, 4924.679895806761, 4939.777710002986, 4985.651004429655, 4868.0, 4937.456879743154, 4938.75306234694, 5259.947400526099, 5678.886422271614, 5778.711064446845, 5893.852653683693, 5949.345571986992, 5951.91072133927, 5960.165576819162, 4084.387341898739, 4130.545639979539, 4138.379243113557, 4150.937735933903, 4154.293770059036, 5409.594280428905, 5602.215689803512, 5663.3665345612835, 5689.459501347365, 5729.570282228766, 5385.946140538545, 5484.588655850907, 5509.586780991522, 5546.75039623226, 5564.527015203753, 5482.506574408322, 5490.5607551395, 5495.697736624524, 5567.777288908398, 5608.588307028017, 5206.5314121729225, 5431.669241035971, 5461.006732542673, 5463.754131064032, 5525.834224973257, 5484.2596249505805, 5513.255710479194, 5527.170924361378, 5551.555875529867, 5555.638883472723, 5412.864678383072, 5440.265564148789, 5441.374241962225, 5474.616776825584, 5487.807926722546], "value": 4124.54409519652, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.7486067585331, 712.4264966701804, 724.4059870905857, 735.7204262380295, 782.0810547606561, 14641.341139648715, 15804.920975395122, 15889.284982175786, 15890.205489725526, 15897.205139742995, 13718.314084295795, 13725.931370343134, 13748.037637365389, 13795.172289662602, 13796.448142074305, 659.8548319369755, 673.8147009572382, 781.6560713286165, 786.866232740434, 790.6481615681024, 808.1675873849944, 810.712197170005, 811.342812322021, 811.5293129984624, 816.9836603267931, 846.0101681033206, 850.2517784349764, 850.961706723199, 851.0808327006848, 851.3359579527978, 684.4626967830229, 685.338648204485, 685.6400389795373, 700.9193942696604, 831.1646794971045, 601.6330038676404, 605.9060845568944, 612.9662868542229, 621.7792683597303, 621.9004959206505, 14070.92964535181, 14073.5074272401, 14090.084144530572, 14106.858931410658, 14116.15303081808, 13459.66350841227, 13942.23317717525, 14507.1295722257, 14630.122192668474, 14731.631709207248, 11404.429778511041, 11405.37270450125, 11498.367589782558, 11687.298762074302, 11716.53133874644, 4118.402831589433, 4173.5409104998425, 4217.135487225111, 4246.7027308088445, 4287.356896465524, 78011.0, 79232.0, 79584.60207698982, 81741.62622205772, 83142.0, 10893.183011274186, 11179.66461006171, 11189.720256993478, 11216.495257713423, 11313.264637798517, 20522.897385512977, 21623.891880540497, 21643.891780541, 21679.241226556995, 21682.56634867294, 8216.356461332007, 8350.123237060143, 8403.453775504573, 8692.782680432912, 8731.694390696295, 4821.9035619288115, 4849.0, 4883.0, 4896.216605343128, 4937.901391908425, 3660.377735784923, 3800.638939300762, 3825.1202223488754, 3826.1582451860545, 3828.406596977473, 703.391566295151, 704.2359040441179, 704.6723273677662, 717.3830505765038, 730.422965856967, 642.3704769326087, 643.0450780590819, 680.2381332907077, 696.2202333386538, 734.8493558820536, 9045.366824322366, 9455.952720236355, 9525.618975240914, 9594.904050959542, 9639.277054220822, 671.278375746075, 680.8025672555002, 688.879446096931, 702.817267510451, 716.7992961970552, 4128.483939507561, 4620.607248383858, 4664.603508701731, 4693.577578017995, 4765.03123632165, 70707.0, 71553.6422317885, 72285.6385718068, 104584.47707761565, 118584.0, 74583.0, 101352.49323753334, 103414.52196692469, 104232.0, 104490.0, 88330.55834720786, 89306.0, 91399.08600914039, 92228.0, 92649.0, 8647.524386158822, 8911.287097032093, 8930.553472326488, 8960.85161418699, 9028.232600229054, 53426.1986070217, 54002.72998634982, 54127.0, 54686.72656636692, 56378.1543276843, 73310.26689733034, 73947.63026184835, 82954.58522707589, 83237.16762832536, 84339.0, 10853.837192441963, 11101.94449027782, 11947.940260298643, 11992.280463172237, 12124.09069319787, 13344.733105338033, 13395.0, 13499.86500134986, 13923.23422211788, 14102.141351159755, 12217.755644887231, 12384.0, 13124.753148450882, 13127.934360328138, 13777.862221378058, 11669.416529173677, 11773.587924422603, 11856.525738970344, 12114.21257618252, 13107.737845243233, 11874.228175168586, 12119.878801211875, 12304.200226985216, 12344.876551234733, 13313.068085234328, 9659.178969787647, 9836.114303832393, 10145.391276523136, 10200.28597998133, 10587.947060264649, 10055.052459408562, 10114.393136411838, 10185.541650625592, 10201.18532436504, 10295.53670084833], "value": 7334.197632535161, "unit": "score"}], "name": "dromaeo_css", "value": 7085.911732307756, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 110.0, 111.0, 112.0, 111.0, 111.0, 109.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 126.0, 182.0, 122.0, 123.0, 121.0, 120.0, 163.0, 128.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 164.0, 163.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 77.0, 75.0, 76.0, 75.0, 108.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 115.0, 84.0, 83.0, 84.0, 101.0, 82.0, 81.0, 114.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 50.0, 51.0, 53.0, 53.0, 52.0, 52.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 80.0, 85.0, 80.0, 79.0, 87.0, 79.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 140.0, 138.0, 139.0, 140.0, 129.0, 138.0, 134.0, 203.0, 130.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 164.0, 166.0, 165.0, 173.0, 166.0, 168.0, 170.0, 168.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 66.0, 66.0, 67.0, 67.0, 69.0, 65.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1513.0000000000005, "alertThreshold": 2.0}]} 06:41:34 INFO - Return code: 0 06:41:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:41:34 INFO - # TBPL SUCCESS # 06:41:34 INFO - Running post-action listener: _resource_record_post_action 06:41:34 INFO - [mozharness: 2016-10-06 13:41:34.993568Z] Finished run-tests step (success) 06:41:34 INFO - Running post-run listener: _resource_record_post_run 06:41:35 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 409833472; Read time: 112; Write time: 239572 06:41:35 INFO - TinderboxPrint: CPU usage
13.0% 06:41:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 06:41:35 INFO - TinderboxPrint: I/O write bytes / time
409,833,472 / 239,572 06:41:35 INFO - TinderboxPrint: CPU idle
8,303.2 (86.9%) 06:41:35 INFO - TinderboxPrint: CPU user
1,196.6 (12.5%) 06:41:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:41:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120516608; Read time: 0; Write time: 69804 06:41:35 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289316864; Read time: 100; Write time: 169768 06:41:35 INFO - Running post-run listener: _upload_blobber_files 06:41:35 INFO - Blob upload gear active. 06:41:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:35 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 06:41:35 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'] 06:41:35 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 06:41:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:37 INFO - (blobuploader) - INFO - Done attempting. 06:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:40 INFO - (blobuploader) - INFO - Done attempting. 06:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:41 INFO - (blobuploader) - INFO - Done attempting. 06:41:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:41 INFO - Return code: 0 06:41:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aaead20ce58e6d1e3b4bc2990dd9dc1444016535b9aa2b2ee11c47be310a7740d84da780def417ade53e578c827fb23fa6feb8ef2ec4987f7ce415af61b59de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1baf203163d1bd956d1e30352f83d2b1c2440f21254091c2025960932f2703442fb7ae320530a003fd1294cafea18e6b171a1d2eccc1f28ba0a8c53cd2deb1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304d743cd90e9a098394bf394db7c18ad3479e5ab7a8c836a6ee88c618ca141531effc2907a6bd7ba6322d6a6f333864259488a8500c9db2d7f4d0667e50969f"} 06:41:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:41 INFO - Contents: 06:41:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aaead20ce58e6d1e3b4bc2990dd9dc1444016535b9aa2b2ee11c47be310a7740d84da780def417ade53e578c827fb23fa6feb8ef2ec4987f7ce415af61b59de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1baf203163d1bd956d1e30352f83d2b1c2440f21254091c2025960932f2703442fb7ae320530a003fd1294cafea18e6b171a1d2eccc1f28ba0a8c53cd2deb1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304d743cd90e9a098394bf394db7c18ad3479e5ab7a8c836a6ee88c618ca141531effc2907a6bd7ba6322d6a6f333864259488a8500c9db2d7f4d0667e50969f"} 06:41:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:41 INFO - Copying logs to upload dir... 06:41:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.295143 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 06:41:40.867840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:41:40.871662) ========= 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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aaead20ce58e6d1e3b4bc2990dd9dc1444016535b9aa2b2ee11c47be310a7740d84da780def417ade53e578c827fb23fa6feb8ef2ec4987f7ce415af61b59de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1baf203163d1bd956d1e30352f83d2b1c2440f21254091c2025960932f2703442fb7ae320530a003fd1294cafea18e6b171a1d2eccc1f28ba0a8c53cd2deb1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304d743cd90e9a098394bf394db7c18ad3479e5ab7a8c836a6ee88c618ca141531effc2907a6bd7ba6322d6a6f333864259488a8500c9db2d7f4d0667e50969f"} build_url:https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/Lqy8zsQ9T2G9m0YV2wBfBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aaead20ce58e6d1e3b4bc2990dd9dc1444016535b9aa2b2ee11c47be310a7740d84da780def417ade53e578c827fb23fa6feb8ef2ec4987f7ce415af61b59de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1baf203163d1bd956d1e30352f83d2b1c2440f21254091c2025960932f2703442fb7ae320530a003fd1294cafea18e6b171a1d2eccc1f28ba0a8c53cd2deb1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304d743cd90e9a098394bf394db7c18ad3479e5ab7a8c836a6ee88c618ca141531effc2907a6bd7ba6322d6a6f333864259488a8500c9db2d7f4d0667e50969f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:41:40.903656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:41:40.904215) ========= 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=4300f881736b422476174874000001bc-1475759784.915697-1065746786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.94 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:41:41.853700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:41:41.854140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:41:41.854847) ========= ========= Total master_lag: 1.07 =========