builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1479403941.65 results: success (0) buildid: 20161117063625 builduid: 115282cd425448b08ba6d96ccc78ad8e revision: 09093d38540e133c7d47061e8ab65b2a9b251758 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.652777) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.653724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.654355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.671931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.672583) ========= 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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 09:32:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 79.5M=0s 2016-11-17 09:32:21 (79.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149964 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.837478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.837826) ========= 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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021831 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.889305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:21.889977) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 09093d38540e133c7d47061e8ab65b2a9b251758 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 09093d38540e133c7d47061e8ab65b2a9b251758 --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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 09:32:22,052 truncating revision to first 12 chars 2016-11-17 09:32:22,052 Setting DEBUG logging. 2016-11-17 09:32:22,053 attempt 1/10 2016-11-17 09:32:22,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/09093d38540e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 09:32:22,516 unpacking tar archive at: mozilla-inbound-09093d38540e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:22.699506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:22.699899) ========= script_repo_revision: 09093d38540e133c7d47061e8ab65b2a9b251758 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:22.700440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:22.700716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:32:22.710884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-17 09:32:22.711385) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:22 INFO - MultiFileLogger online at 20161117 09:32:22 in /builds/slave/test 09:32:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:32:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:22 INFO - {'append_to_log': False, 09:32:22 INFO - 'base_work_dir': '/builds/slave/test', 09:32:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:32:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:22 INFO - 'branch': 'Mozilla-Inbound', 09:32:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:22 INFO - 'config_files': ('talos/linux_config.py',), 09:32:22 INFO - 'default_actions': ('clobber', 09:32:22 INFO - 'read-buildbot-config', 09:32:22 INFO - 'download-and-extract', 09:32:22 INFO - 'populate-webroot', 09:32:22 INFO - 'create-virtualenv', 09:32:22 INFO - 'install', 09:32:22 INFO - 'run-tests'), 09:32:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:22 INFO - 'download_minidump_stackwalk': True, 09:32:22 INFO - 'download_symbols': 'ondemand', 09:32:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:22 INFO - 'installer_path': 'installer.exe', 09:32:22 INFO - 'log_level': 'info', 09:32:22 INFO - 'log_name': 'talos', 09:32:22 INFO - 'log_to_console': True, 09:32:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:22 INFO - 'opt_config_files': (), 09:32:22 INFO - 'pip_index': False, 09:32:22 INFO - 'sps_profile': False, 09:32:22 INFO - 'sps_profile_interval': 0, 09:32:22 INFO - 'suite': 'dromaeojs', 09:32:22 INFO - 'system_bits': '32', 09:32:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:22 INFO - 'title': 'talos-linux64-ix-039', 09:32:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:22 INFO - 'use_talos_json': True, 09:32:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:22 INFO - 'work_dir': 'build'} 09:32:22 INFO - [mozharness: 2016-11-17 17:32:22.962918Z] Running clobber step. 09:32:22 INFO - Running pre-action listener: _resource_record_pre_action 09:32:22 INFO - Running main action method: clobber 09:32:22 INFO - rmtree: /builds/slave/test/build 09:32:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:23 INFO - Running post-action listener: _resource_record_post_action 09:32:23 INFO - [mozharness: 2016-11-17 17:32:23.445939Z] Finished clobber step (success) 09:32:23 INFO - [mozharness: 2016-11-17 17:32:23.446038Z] Running read-buildbot-config step. 09:32:23 INFO - Running pre-action listener: _resource_record_pre_action 09:32:23 INFO - Running main action method: read_buildbot_config 09:32:23 INFO - Using buildbot properties: 09:32:23 INFO - { 09:32:23 INFO - "project": "", 09:32:23 INFO - "product": "firefox", 09:32:23 INFO - "script_repo_revision": "production", 09:32:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:32:23 INFO - "repository": "", 09:32:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:32:23 INFO - "buildid": "20161117063625", 09:32:23 INFO - "pgo_build": "True", 09:32:23 INFO - "basedir": "/builds/slave/test", 09:32:23 INFO - "buildnumber": 2106, 09:32:23 INFO - "slavename": "talos-linux64-ix-039", 09:32:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:32:23 INFO - "platform": "ubuntu64_hw", 09:32:23 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:32:23 INFO - "branch": "mozilla-inbound", 09:32:23 INFO - "repo_path": "integration/mozilla-inbound", 09:32:23 INFO - "revision": "09093d38540e133c7d47061e8ab65b2a9b251758", 09:32:23 INFO - "stage_platform": "linux64-pgo", 09:32:23 INFO - "builduid": "115282cd425448b08ba6d96ccc78ad8e", 09:32:23 INFO - "slavebuilddir": "test" 09:32:23 INFO - } 09:32:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:32:23 INFO - Running post-action listener: _resource_record_post_action 09:32:23 INFO - [mozharness: 2016-11-17 17:32:23.448530Z] Finished read-buildbot-config step (success) 09:32:23 INFO - [mozharness: 2016-11-17 17:32:23.448619Z] Running download-and-extract step. 09:32:23 INFO - Running pre-action listener: _resource_record_pre_action 09:32:23 INFO - Running main action method: download_and_extract 09:32:23 INFO - mkdir: /builds/slave/test/build/tests 09:32: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')]} 09:32:23 INFO - trying https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:32:23 INFO - Downloading https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:32:24 INFO - Downloaded 1361 bytes. 09:32:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:32:24 INFO - Using the following test package requirements: 09:32:24 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:32:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'jsshell-linux-x86_64.zip'], 09:32:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:32:24 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:32:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:32:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:24 INFO - Fetch https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:32:24 INFO - Http code: 200 09:32:24 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 09:32:24 INFO - x-amz-cf-id: wT2pvq2zXHrEYmMG62DUn7Xi7aJ1ZIwOlQ-ZOerIWbtqEPwpNr5UtQ== 09:32:24 INFO - x-amz-version-id: YbdohRF8aIlft3ZlwfWTqNHvvih.PP9u 09:32:24 INFO - Expected file size: 21917497 09:32:24 INFO - Obtained file size: 21917497 09:32:28 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:32:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:32:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:32:29 INFO - Http code: 200 09:32:29 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:32:29 INFO - x-amz-cf-id: fdWDtOclkkObwPihbzVWIE-b2-cFQ-PYJvmp74405SA4Y5YwDuM1HA== 09:32:29 INFO - x-amz-version-id: YbdohRF8aIlft3ZlwfWTqNHvvih.PP9u 09:32:29 INFO - Expected file size: 21917497 09:32:29 INFO - Obtained file size: 21917497 09:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:32:34 INFO - Http code: 200 09:32:34 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:32:34 INFO - x-amz-cf-id: sVOHJo037JLVuPwxyjxEu-zJissWWBxaZn6MAze6YFbPUEL9yi8uzA== 09:32:34 INFO - x-amz-version-id: OentXV1JFFLv45CuxTZl._E92jFBXcuL 09:32:34 INFO - Expected file size: 14409392 09:32:34 INFO - Obtained file size: 14409392 09:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:35 INFO - trying https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:32:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:32:36 INFO - Downloaded 59583474 bytes. 09:32:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:32:36 INFO - mkdir: /builds/slave/test/properties 09:32:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:36 INFO - Contents: 09:32:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:32:37 INFO - Running post-action listener: _resource_record_post_action 09:32:37 INFO - Running post-action listener: set_extra_try_arguments 09:32:37 INFO - [mozharness: 2016-11-17 17:32:37.025250Z] Finished download-and-extract step (success) 09:32:37 INFO - [mozharness: 2016-11-17 17:32:37.025479Z] Running populate-webroot step. 09:32:37 INFO - Running pre-action listener: _resource_record_pre_action 09:32:37 INFO - Running main action method: populate_webroot 09:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:37 INFO - '--tppagecycles', 09:32:37 INFO - '7'], 09:32:37 INFO - 'tests': ['tsvgm']}}, 09:32:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['damp', 'tps']}, 09:32:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'tests': ['damp', 'tps']}, 09:32:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['dromaeo_dom']}, 09:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['basic_compositor_video']}, 09:32:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:32:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tsvgx', 09:32:37 INFO - 'tsvgr_opacity', 09:32:37 INFO - 'tart', 09:32:37 INFO - 'tscrollx', 09:32:37 INFO - 'cart']}, 09:32:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:37 INFO - 'tsvgr_opacity', 09:32:37 INFO - 'tart', 09:32:37 INFO - 'tscrollx', 09:32:37 INFO - 'cart']}, 09:32:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tp5o']}, 09:32:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:32:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s', 09:32:37 INFO - '--xperf_path', 09:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:37 INFO - 'tests': ['tp5n']}, 09:32:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--xperf_path', 09:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:37 INFO - 'tests': ['tp5n']}}, 09:32:37 INFO - 'talos.zip': {'path': '', 09:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:37 INFO - Running post-action listener: _resource_record_post_action 09:32:37 INFO - [mozharness: 2016-11-17 17:32:37.044640Z] Finished populate-webroot step (success) 09:32:37 INFO - [mozharness: 2016-11-17 17:32:37.044729Z] Running create-virtualenv step. 09:32:37 INFO - Running pre-action listener: _resource_record_pre_action 09:32:37 INFO - Running main action method: create_virtualenv 09:32:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:37 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 09:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:37 INFO - Using real prefix '/usr' 09:32:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:39 INFO - Installing pip.................done. 09:32:39 INFO - Return code: 0 09:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:39 INFO - Reading from file tmpfile_stdout 09:32:39 INFO - Output received: 09:32:39 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) 09:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:32:39 INFO - Using env: {'DISPLAY': ':0', 09:32:39 INFO - 'HOME': '/home/cltbld', 09:32:39 INFO - 'LANG': 'en_US.UTF-8', 09:32:39 INFO - 'LANGUAGE': 'en_US:en', 09:32:39 INFO - 'LOGNAME': 'cltbld', 09:32:39 INFO - 'MAIL': '/var/mail/cltbld', 09:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:39 INFO - 'MOZ_NO_REMOTE': '1', 09:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:39 INFO - 'NO_EM_RESTART': '1', 09:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:39 INFO - 'PWD': '/builds/slave/test', 09:32:39 INFO - 'SHELL': '/bin/bash', 09:32:39 INFO - 'SHLVL': '1', 09:32:39 INFO - 'TERM': 'linux', 09:32:39 INFO - 'TMOUT': '86400', 09:32:39 INFO - 'USER': 'cltbld', 09:32:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:39 INFO - '_': '/tools/buildbot/bin/python'} 09:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:40 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 09:32:40 INFO - Cleaning up... 09:32:40 INFO - Return code: 0 09:32:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:32:40 INFO - Using env: {'DISPLAY': ':0', 09:32:40 INFO - 'HOME': '/home/cltbld', 09:32:40 INFO - 'LANG': 'en_US.UTF-8', 09:32:40 INFO - 'LANGUAGE': 'en_US:en', 09:32:40 INFO - 'LOGNAME': 'cltbld', 09:32:40 INFO - 'MAIL': '/var/mail/cltbld', 09:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:40 INFO - 'MOZ_NO_REMOTE': '1', 09:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:40 INFO - 'NO_EM_RESTART': '1', 09:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:40 INFO - 'PWD': '/builds/slave/test', 09:32:40 INFO - 'SHELL': '/bin/bash', 09:32:40 INFO - 'SHLVL': '1', 09:32:40 INFO - 'TERM': 'linux', 09:32:40 INFO - 'TMOUT': '86400', 09:32:40 INFO - 'USER': 'cltbld', 09:32:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:40 INFO - '_': '/tools/buildbot/bin/python'} 09:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:40 INFO - Downloading/unpacking psutil>=3.1.1 09:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:42 INFO - Installing collected packages: psutil 09:32:42 INFO - Running setup.py install for psutil 09:32:42 INFO - building 'psutil._psutil_linux' extension 09:32:42 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 09:32:42 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 09:32:42 INFO - building 'psutil._psutil_posix' extension 09:32:42 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 09:32:42 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 09:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:42 INFO - Successfully installed psutil 09:32:42 INFO - Cleaning up... 09:32:42 INFO - Return code: 0 09:32:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:42 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')]} 09:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:42 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')]} 09:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:42 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:42 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 09:32:42 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 09:32:42 INFO - Using env: {'DISPLAY': ':0', 09:32:42 INFO - 'HOME': '/home/cltbld', 09:32:42 INFO - 'LANG': 'en_US.UTF-8', 09:32:42 INFO - 'LANGUAGE': 'en_US:en', 09:32:42 INFO - 'LOGNAME': 'cltbld', 09:32:42 INFO - 'MAIL': '/var/mail/cltbld', 09:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:42 INFO - 'MOZ_NO_REMOTE': '1', 09:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:42 INFO - 'NO_EM_RESTART': '1', 09:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:42 INFO - 'PWD': '/builds/slave/test', 09:32:42 INFO - 'SHELL': '/bin/bash', 09:32:42 INFO - 'SHLVL': '1', 09:32:42 INFO - 'TERM': 'linux', 09:32:42 INFO - 'TMOUT': '86400', 09:32:42 INFO - 'USER': 'cltbld', 09:32:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:42 INFO - '_': '/tools/buildbot/bin/python'} 09:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:43 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 09:32:43 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 09:32:43 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 09:32:43 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 09:32:43 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 09:32:43 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 09:32:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:45 INFO - Installing collected packages: mozsystemmonitor 09:32:45 INFO - Running setup.py install for mozsystemmonitor 09:32:45 INFO - Successfully installed mozsystemmonitor 09:32:45 INFO - Cleaning up... 09:32:45 INFO - Return code: 0 09:32:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:45 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')]} 09:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:45 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')]} 09:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:45 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:45 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 09:32:45 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 09:32:45 INFO - Using env: {'DISPLAY': ':0', 09:32:45 INFO - 'HOME': '/home/cltbld', 09:32:45 INFO - 'LANG': 'en_US.UTF-8', 09:32:45 INFO - 'LANGUAGE': 'en_US:en', 09:32:45 INFO - 'LOGNAME': 'cltbld', 09:32:45 INFO - 'MAIL': '/var/mail/cltbld', 09:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:45 INFO - 'MOZ_NO_REMOTE': '1', 09:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:45 INFO - 'NO_EM_RESTART': '1', 09:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:45 INFO - 'PWD': '/builds/slave/test', 09:32:45 INFO - 'SHELL': '/bin/bash', 09:32:45 INFO - 'SHLVL': '1', 09:32:45 INFO - 'TERM': 'linux', 09:32:45 INFO - 'TMOUT': '86400', 09:32:45 INFO - 'USER': 'cltbld', 09:32:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:45 INFO - '_': '/tools/buildbot/bin/python'} 09:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:45 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 09:32:45 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 09:32:45 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 09:32:45 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 09:32:45 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 09:32:45 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 09:32:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32:47 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 09:32:47 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 09:32:47 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 09:32:47 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 09:32:47 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 09:32:47 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 09:32:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:47 INFO - warning: no files found matching '*.txt' 09:32:47 INFO - no previously-included directories found matching 'build' 09:32:47 INFO - no previously-included directories found matching 'dist' 09:32:47 INFO - no previously-included directories found matching '.git*' 09:32:47 INFO - Installing collected packages: jsonschema, functools32 09:32:47 INFO - Running setup.py install for functools32 09:32:47 INFO - warning: no files found matching '*.txt' 09:32:47 INFO - no previously-included directories found matching 'build' 09:32:47 INFO - no previously-included directories found matching 'dist' 09:32:47 INFO - no previously-included directories found matching '.git*' 09:32:47 INFO - Successfully installed jsonschema functools32 09:32:47 INFO - Cleaning up... 09:32:47 INFO - Return code: 0 09:32:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:47 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:47 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 09:32:47 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 09:32:47 INFO - Using env: {'DISPLAY': ':0', 09:32:47 INFO - 'HOME': '/home/cltbld', 09:32:47 INFO - 'LANG': 'en_US.UTF-8', 09:32:47 INFO - 'LANGUAGE': 'en_US:en', 09:32:47 INFO - 'LOGNAME': 'cltbld', 09:32:47 INFO - 'MAIL': '/var/mail/cltbld', 09:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:47 INFO - 'MOZ_NO_REMOTE': '1', 09:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:47 INFO - 'NO_EM_RESTART': '1', 09:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:47 INFO - 'PWD': '/builds/slave/test', 09:32:47 INFO - 'SHELL': '/bin/bash', 09:32:47 INFO - 'SHLVL': '1', 09:32:47 INFO - 'TERM': 'linux', 09:32:47 INFO - 'TMOUT': '86400', 09:32:47 INFO - 'USER': 'cltbld', 09:32:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:47 INFO - '_': '/tools/buildbot/bin/python'} 09:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:48 INFO - Cleaning up... 09:32:48 INFO - Return code: 0 09:32:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:48 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:48 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 09:32:48 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 09:32:48 INFO - Using env: {'DISPLAY': ':0', 09:32:48 INFO - 'HOME': '/home/cltbld', 09:32:48 INFO - 'LANG': 'en_US.UTF-8', 09:32:48 INFO - 'LANGUAGE': 'en_US:en', 09:32:48 INFO - 'LOGNAME': 'cltbld', 09:32:48 INFO - 'MAIL': '/var/mail/cltbld', 09:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:48 INFO - 'MOZ_NO_REMOTE': '1', 09:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:48 INFO - 'NO_EM_RESTART': '1', 09:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:48 INFO - 'PWD': '/builds/slave/test', 09:32:48 INFO - 'SHELL': '/bin/bash', 09:32:48 INFO - 'SHLVL': '1', 09:32:48 INFO - 'TERM': 'linux', 09:32:48 INFO - 'TMOUT': '86400', 09:32:48 INFO - 'USER': 'cltbld', 09:32:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:48 INFO - '_': '/tools/buildbot/bin/python'} 09:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:51 INFO - Downloading docopt-0.6.1.tar.gz 09:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:51 INFO - Running setup.py install for blobuploader 09:32:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:51 INFO - Running setup.py install for requests 09:32:51 INFO - Running setup.py install for docopt 09:32:51 INFO - Successfully installed blobuploader requests docopt 09:32:51 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:51 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 09:32:51 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 09:32:51 INFO - Using env: {'DISPLAY': ':0', 09:32:51 INFO - 'HOME': '/home/cltbld', 09:32:51 INFO - 'LANG': 'en_US.UTF-8', 09:32:51 INFO - 'LANGUAGE': 'en_US:en', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MAIL': '/var/mail/cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SHLVL': '1', 09:32:51 INFO - 'TERM': 'linux', 09:32:51 INFO - 'TMOUT': '86400', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - '_': '/tools/buildbot/bin/python'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:51 INFO - Running setup.py (path:/tmp/pip-ONTWFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:51 INFO - Running setup.py (path:/tmp/pip-LN2oUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:52 INFO - Running setup.py (path:/tmp/pip-EImUfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:52 INFO - Running setup.py (path:/tmp/pip-kwvgHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:52 INFO - Running setup.py (path:/tmp/pip-NshLuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:52 INFO - Running setup.py (path:/tmp/pip-x6eQMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:52 INFO - Running setup.py (path:/tmp/pip-NRgeXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:52 INFO - Running setup.py (path:/tmp/pip-VzXeGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:52 INFO - Running setup.py (path:/tmp/pip-Y72_q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:52 INFO - Running setup.py (path:/tmp/pip-UpWRp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:52 INFO - Running setup.py (path:/tmp/pip-qog8e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:52 INFO - Running setup.py (path:/tmp/pip-dPnbZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:52 INFO - Running setup.py (path:/tmp/pip-OVHQBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:52 INFO - Running setup.py (path:/tmp/pip-wT6PAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:52 INFO - Running setup.py (path:/tmp/pip-1bubSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:52 INFO - Running setup.py (path:/tmp/pip-25bDQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:53 INFO - Running setup.py (path:/tmp/pip-k2xZTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:53 INFO - Running setup.py install for manifestparser 09:32:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Running setup.py install for mozcrash 09:32:53 INFO - Running setup.py install for mozdebug 09:32:53 INFO - Running setup.py install for mozdevice 09:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Running setup.py install for mozfile 09:32:53 INFO - Running setup.py install for mozhttpd 09:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Running setup.py install for mozinfo 09:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Running setup.py install for mozInstall 09:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:53 INFO - Running setup.py install for mozleak 09:32:54 INFO - Running setup.py install for mozlog 09:32:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Running setup.py install for moznetwork 09:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Running setup.py install for mozprocess 09:32:54 INFO - Running setup.py install for mozprofile 09:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Running setup.py install for mozrunner 09:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Running setup.py install for mozscreenshot 09:32:54 INFO - Running setup.py install for moztest 09:32:54 INFO - Running setup.py install for mozversion 09:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:54 INFO - Cleaning up... 09:32:54 INFO - Return code: 0 09:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:54 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 09:32:54 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 09:32:54 INFO - Using env: {'DISPLAY': ':0', 09:32:54 INFO - 'HOME': '/home/cltbld', 09:32:54 INFO - 'LANG': 'en_US.UTF-8', 09:32:54 INFO - 'LANGUAGE': 'en_US:en', 09:32:54 INFO - 'LOGNAME': 'cltbld', 09:32:54 INFO - 'MAIL': '/var/mail/cltbld', 09:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:54 INFO - 'MOZ_NO_REMOTE': '1', 09:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:54 INFO - 'NO_EM_RESTART': '1', 09:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:54 INFO - 'PWD': '/builds/slave/test', 09:32:54 INFO - 'SHELL': '/bin/bash', 09:32:54 INFO - 'SHLVL': '1', 09:32:54 INFO - 'TERM': 'linux', 09:32:54 INFO - 'TMOUT': '86400', 09:32:54 INFO - 'USER': 'cltbld', 09:32:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:54 INFO - '_': '/tools/buildbot/bin/python'} 09:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:55 INFO - Running setup.py (path:/tmp/pip-p5FNzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:55 INFO - Running setup.py (path:/tmp/pip-wk7jvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:55 INFO - Running setup.py (path:/tmp/pip-EMZICW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:55 INFO - Running setup.py (path:/tmp/pip-uisHim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:55 INFO - Running setup.py (path:/tmp/pip-_6lDhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:55 INFO - Running setup.py (path:/tmp/pip-ydPDg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:55 INFO - Running setup.py (path:/tmp/pip-u3RtJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:55 INFO - Running setup.py (path:/tmp/pip-yHgdkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:55 INFO - Running setup.py (path:/tmp/pip-XZkCxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:55 INFO - Running setup.py (path:/tmp/pip-LMvUoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:55 INFO - Running setup.py (path:/tmp/pip-PElHbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:55 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)) 09:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:55 INFO - Running setup.py (path:/tmp/pip-LA22NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:56 INFO - Running setup.py (path:/tmp/pip-MaV8Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:56 INFO - Running setup.py (path:/tmp/pip-43cqZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:56 INFO - Running setup.py (path:/tmp/pip-acexut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:56 INFO - Running setup.py (path:/tmp/pip-7n7tCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:56 INFO - Running setup.py (path:/tmp/pip-qz98zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:56 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)) 09:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:56 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)) 09:32:56 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)) 09:32:56 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)) 09:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:58 INFO - Downloading blessings-1.6.tar.gz 09:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:58 INFO - Installing collected packages: blessings 09:32:58 INFO - Running setup.py install for blessings 09:32:58 INFO - Successfully installed blessings 09:32:58 INFO - Cleaning up... 09:32:58 INFO - Return code: 0 09:32:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:58 INFO - Reading from file tmpfile_stdout 09:32:58 INFO - Current package versions: 09:32:58 INFO - argparse == 1.2.1 09:32:58 INFO - blessings == 1.6 09:32:58 INFO - blobuploader == 1.2.4 09:32:58 INFO - docopt == 0.6.1 09:32:58 INFO - functools32 == 3.2.3-2 09:32:58 INFO - jsonschema == 2.5.1 09:32:58 INFO - manifestparser == 1.1 09:32:58 INFO - mozInstall == 1.12 09:32:58 INFO - mozcrash == 1.0 09:32:58 INFO - mozdebug == 0.1 09:32:58 INFO - mozdevice == 0.48 09:32:58 INFO - mozfile == 1.2 09:32:58 INFO - mozhttpd == 0.7 09:32:58 INFO - mozinfo == 0.9 09:32:58 INFO - mozleak == 0.1 09:32:58 INFO - mozlog == 3.4 09:32:58 INFO - moznetwork == 0.27 09:32:58 INFO - mozprocess == 0.23 09:32:58 INFO - mozprofile == 0.28 09:32:58 INFO - mozrunner == 6.13 09:32:58 INFO - mozscreenshot == 0.1 09:32:58 INFO - mozsystemmonitor == 0.3 09:32:58 INFO - moztest == 0.7 09:32:58 INFO - mozversion == 1.4 09:32:58 INFO - psutil == 3.1.1 09:32:58 INFO - requests == 1.2.3 09:32:58 INFO - wsgiref == 0.1.2 09:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:58 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')]} 09:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:58 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')]} 09:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:58 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 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:58 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 09:32:58 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 09:32:58 INFO - Using env: {'DISPLAY': ':0', 09:32:58 INFO - 'HOME': '/home/cltbld', 09:32:58 INFO - 'LANG': 'en_US.UTF-8', 09:32:58 INFO - 'LANGUAGE': 'en_US:en', 09:32:58 INFO - 'LOGNAME': 'cltbld', 09:32:58 INFO - 'MAIL': '/var/mail/cltbld', 09:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:58 INFO - 'MOZ_NO_REMOTE': '1', 09:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:58 INFO - 'NO_EM_RESTART': '1', 09:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:58 INFO - 'PWD': '/builds/slave/test', 09:32:58 INFO - 'SHELL': '/bin/bash', 09:32:58 INFO - 'SHLVL': '1', 09:32:58 INFO - 'TERM': 'linux', 09:32:58 INFO - 'TMOUT': '86400', 09:32:58 INFO - 'USER': 'cltbld', 09:32:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:58 INFO - '_': '/tools/buildbot/bin/python'} 09:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 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)) 09:32:59 INFO - Cleaning up... 09:32:59 INFO - Return code: 0 09:32:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4867c95e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb8bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, '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': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', '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 09:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:32:59 INFO - Using env: {'DISPLAY': ':0', 09:32:59 INFO - 'HOME': '/home/cltbld', 09:32:59 INFO - 'LANG': 'en_US.UTF-8', 09:32:59 INFO - 'LANGUAGE': 'en_US:en', 09:32:59 INFO - 'LOGNAME': 'cltbld', 09:32:59 INFO - 'MAIL': '/var/mail/cltbld', 09:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:59 INFO - 'MOZ_NO_REMOTE': '1', 09:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:59 INFO - 'NO_EM_RESTART': '1', 09:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:59 INFO - 'PWD': '/builds/slave/test', 09:32:59 INFO - 'SHELL': '/bin/bash', 09:32:59 INFO - 'SHLVL': '1', 09:32:59 INFO - 'TERM': 'linux', 09:32:59 INFO - 'TMOUT': '86400', 09:32:59 INFO - 'USER': 'cltbld', 09:32:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:59 INFO - '_': '/tools/buildbot/bin/python'} 09:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:59 INFO - Cleaning up... 09:32:59 INFO - Return code: 0 09:32:59 INFO - Running post-action listener: _resource_record_post_action 09:32:59 INFO - Running post-action listener: _start_resource_monitoring 09:32:59 INFO - Starting resource monitoring. 09:32:59 INFO - [mozharness: 2016-11-17 17:32:59.380280Z] Finished create-virtualenv step (success) 09:32:59 INFO - [mozharness: 2016-11-17 17:32:59.380752Z] Running install step. 09:32:59 INFO - Running pre-action listener: _resource_record_pre_action 09:32:59 INFO - Running main action method: install 09:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:59 INFO - Reading from file tmpfile_stdout 09:32:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:59 INFO - Reading from file tmpfile_stdout 09:32:59 INFO - Output received: 09:32:59 INFO - Usage: mozinstall [options] installer 09:32:59 INFO - Options: 09:32:59 INFO - -h, --help show this help message and exit 09:32:59 INFO - -d DEST, --destination=DEST 09:32:59 INFO - Directory to install application into. [default: 09:32:59 INFO - "/builds/slave/test"] 09:32:59 INFO - --app=APP Application being installed. [default: firefox] 09:32:59 INFO - mkdir: /builds/slave/test/build/application 09:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:16 INFO - Reading from file tmpfile_stdout 09:33:16 INFO - Output received: 09:33:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - [mozharness: 2016-11-17 17:33:16.614234Z] Finished install step (success) 09:33:16 INFO - [mozharness: 2016-11-17 17:33:16.614478Z] Running run-tests step. 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: run_tests 09:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:16 INFO - Python 2.7.3 09:33:16 INFO - Return code: 0 09:33:16 INFO - grabbing minidump binary from tooltool 09:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:16 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 0xdb5fc0>, '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 0xdb6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:16 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 09:33:16 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 09:33:16 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 09:33:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:16 INFO - Return code: 0 09:33:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 09:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 09:33:16 INFO - Using env: {'DISPLAY': ':0', 09:33:16 INFO - 'HOME': '/home/cltbld', 09:33:16 INFO - 'LANG': 'en_US.UTF-8', 09:33:16 INFO - 'LANGUAGE': 'en_US:en', 09:33:16 INFO - 'LOGNAME': 'cltbld', 09:33:16 INFO - 'MAIL': '/var/mail/cltbld', 09:33:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:16 INFO - 'MOZ_NO_REMOTE': '1', 09:33:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:16 INFO - 'NO_EM_RESTART': '1', 09:33:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:16 INFO - 'PWD': '/builds/slave/test', 09:33:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:16 INFO - 'SHELL': '/bin/bash', 09:33:16 INFO - 'SHLVL': '1', 09:33:16 INFO - 'TERM': 'linux', 09:33:16 INFO - 'TMOUT': '86400', 09:33:16 INFO - 'USER': 'cltbld', 09:33:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099', 09:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:16 INFO - '_': '/tools/buildbot/bin/python'} 09:33:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 09:33:16 INFO - mozversion application_buildid: 20161117063625 09:33:16 INFO - mozversion application_changeset: 09093d38540e133c7d47061e8ab65b2a9b251758 09:33:16 INFO - mozversion application_display_name: Nightly 09:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:16 INFO - mozversion application_name: Firefox 09:33:16 INFO - mozversion application_remotingname: firefox 09:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:33:16 INFO - mozversion application_vendor: Mozilla 09:33:16 INFO - mozversion application_version: 53.0a1 09:33:16 INFO - mozversion platform_buildid: 20161117063625 09:33:16 INFO - mozversion platform_changeset: 09093d38540e133c7d47061e8ab65b2a9b251758 09:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:33:16 INFO - mozversion platform_version: 53.0a1 09:33:16 INFO - using testdate: 1479403996 09:33:16 INFO - actual date: 1479403996 09:33:16 INFO - starting webserver on 'localhost:37039' 09:33:16 INFO - SUITE-START | Running 2 tests 09:33:16 INFO - TEST-START | dromaeo_css 09:33:16 INFO - operating with platform_type : linux_ 09:33:16 INFO - Initialising browser for dromaeo_css test... 09:33:16 INFO - TEST-INFO | started process 23785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK_RHFJ/profile http://localhost:37039/getInfo.html) 09:33:21 INFO - PROCESS | 23785 | __metrics Screen width/height:1600/1200 09:33:21 INFO - PROCESS | 23785 | colorDepth:24 09:33:21 INFO - PROCESS | 23785 | Browser inner width/height: 1024/697 09:33:21 INFO - PROCESS | 23785 | __metrics 09:33:22 INFO - PROCESS | 23785 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:22 INFO - PROCESS | 23785 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:22 INFO - PROCESS | 23785 | console.error: PushService: 09:33:22 INFO - PROCESS | 23785 | stateChangeProcessEnqueue: Error transitioning state 09:33:22 INFO - PROCESS | 23785 | UnknownError 09:33:23 INFO - TEST-INFO | 23785: exit 0 09:33:23 INFO - Browser initialized. 09:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:23 INFO - TEST-INFO | started process 23871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK_RHFJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:35 INFO - PROCESS | 23871 | RSS: Main: 173518848 09:33:35 INFO - PROCESS | 23871 | 09:34:27 INFO - PROCESS | 23871 | 1479404067361 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] 09:36:37 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37039/tests/dromaeo/cssquery-ext.html) 09:36:39 INFO - PROCESS | 23871 | RSS: Main: 320012288 09:36:39 INFO - PROCESS | 23871 | 09:39:41 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-ext.html (next: http://localhost:37039/tests/dromaeo/cssquery-jquery.html) 09:39:42 INFO - PROCESS | 23871 | RSS: Main: 272203776 09:39:42 INFO - PROCESS | 23871 | 09:42:44 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37039/tests/dromaeo/cssquery-mootools.html) 09:42:44 INFO - PROCESS | 23871 | RSS: Main: 217165824 09:42:44 INFO - PROCESS | 23871 | 09:45:46 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37039/tests/dromaeo/cssquery-prototype.html) 09:45:47 INFO - PROCESS | 23871 | RSS: Main: 272531456 09:45:47 INFO - PROCESS | 23871 | 09:48:50 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37039/tests/dromaeo/cssquery-yui.html) 09:48:50 INFO - PROCESS | 23871 | RSS: Main: 218030080 09:48:50 INFO - PROCESS | 23871 | 09:51:53 INFO - PROCESS | 23871 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-yui.html (next: http://localhost:37039/tests/dromaeo/cssquery-dojo.html) 09:51:54 INFO - PROCESS | 23871 | RSS: Main: 304771072 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | __start_tp_report 09:51:54 INFO - PROCESS | 23871 | _x_x_mozilla_page_load 09:51:54 INFO - PROCESS | 23871 | _x_x_mozilla_page_load_details 09:51:54 INFO - PROCESS | 23871 | |i|pagename|runs| 09:51:54 INFO - PROCESS | 23871 | |0;dojo.html;2965.5255159174535;2974.8363839988792;2996.2808925857803;3032.8938487152955;3041.254892551325;5208.8437346879655;5223.738813059351;5289.656172348795;5325.840224793253;5329.280547126142;5187.144121220003;5254.211868219769;5259.526642602165;5298.841034768953;5321.281626980356;4730.243161094226;4779.354787103749;4809.51904809518;4809.735464549449;4863.1732605457155;4914.582260507861;4925.408950925894;4951.752412379366;4969.304297398367;5014.974925125369;4761.333413322138;4863.635227357962;4865.9026819463415;4876.585490233334;4957.330760347361;4766.165920963852;4780.11567859947;4794.616430685537;4817.735024573647;4841.975790121062;4789.161896668104;4796.688215265996;4797.424309082898;4831.879203019917;4854.878628034292;5243.187305967581;5276.868078298035;5279.366476022863;5289.206619007141;5297.17893726473;5498.1752737089755;5514.531264842493;5540.63985840919;5550.27846379972;5620.803271885465;5632.718364081779;5638.182463542763;5638.520725738317;5670.829875103754;5686.800961966312;5243.187305967581;5251.579873610141;5252.23842542833;5256.658317209369;5302.443243459458;5595.4124816894455;5632.7746890123935;5719.914201286984;5736.196932429463;5750.856228594319;5528.06022976095;5563.693996830213;5569.387367389584;5613.410591887875;5613.859653508695;5574.9721251393485;5589.301337332833;5616.943830561724;5631.4087020863035;5633.887322253532;5402.432744561765;5447.4552544746;5589;5605.831825045255;5618.101103823368;5527.226188333637;5536.916946245729;5567.860803479864;5606.803761868315;5621.072523033654;4305.84929527465;4308.073764140725;4351.608355248043;4365.301551751704;4404.8458303959205;3868.825902834379;3871;3889.766614003169;3898.3957486589625;3935.665468435158;5245.632805703564;5274.604404669665;5361.812336568201;5372.838814835483;5413.2150838128255;5627.493525582717;5628.859278517988;5630.577706672016;5646.463585959327;5654.802081927113;5187.662801917863;5312.2297266896085;5323.254744335796;5324.41431442541;5370.1407774756635;4805.399325084364;4829.106615276185;4839.491853355347;4845;4879.097366987119;5804.9419505805245;5815.912761308499;5818.33089194748;5821.825345239734;5822.82531524055;5572.442755724395;5579.525740312119;5582.106862901916;5589.07780216276;5593.748281327269;5704.828855134187;5768.653880767168;5778.653280803165;5795.420457954171;5824.271966004249;5533.806316778893;5533.806316778893;5548.667079975215;5577;5590.413006634408;5582.86042848932;5597.944020559905;5635.0702134147405;5637.646964728354;5640.830775076754;5398.1902714593125;5416.864578385572;5467.808626698046;5512.2558454608115;5555;5430.70131142791;5501.972490137684;5506.669599824023;5546.168074788814;5552.333719953632;5479.53423958968;5484.917726234189;5486.369067557122;5490.149026900836;5491.313585801775;5466.480684334982;5506.862328441821;5533.418991005887;5560.277163968658;5617.43825617435;5378;5453.672779633234;5456.48163424474;5500.779968801203;5508.91736623943 09:51:54 INFO - PROCESS | 23871 | |1;ext.html;545.8281803557645;584.6755050946724;591.0189086117044;593.5370411079359;594.2838879150623;32224.355512889757;32974.835125824364;41346.37980430296;42209.57790422095;42341.153176936445;39833.20333593326;42588.78705606476;42596;42598.14803703924;42640.573594264046;7951.761447156566;8652.567371631425;8815.603297851612;8818.603162857687;8825.249853762438;8102.108768035541;10270.589176432934;10473.423961682105;10513.264071514997;10847.403392813392;10633.946830265837;10656.094231990252;10693.625723099693;10708.839367409495;10711.196660250473;10488.265821392506;10521.473926303654;10537.525811338432;10545.261831671785;10551;10515.316504427188;10559.841602375971;10571.154307655446;10581.31221470602;10583.259171857973;41568.37647435291;41664.375034374505;41981.58018419807;42019.36970945408;42037.57962420398;3242.3191129862757;3277.6886195811358;3309.4373956427467;3365.5793025871767;3454.671806178409;30451.13901434301;31227.843860780777;31230.843845780626;31301.217469563217;31580.210494737585;4031.677465802758;4163.417121602978;4196.454460920091;4244.214820258262;4369.71596846204;314444;315629.99999999773;316169;316661;317145;57042.42957570454;57588.71205643945;57666.42333576694;57669.4233057664;57682.7115864418;59780.40219597836;59952.400475994684;60320.39679603148;60421.69789151026;60576.39423605796;16660.16699165037;16842.157892105344;16845.91577042107;16847.915760421365;16866.241019154168;11560.76878462426;11901.821472677917;12778.552750653682;13046.47814087445;13159.736805263841;17123.65752684964;17173.227204775816;17180.735660224516;17183.3985810496;17189.1405429728;5551.500364967173;6676.732930682719;6751.493637977172;6754.76358327466;6851.657417129223;951.5622813505727;991.4893829677721;1030.7577719235974;1078.7755897056898;1122.3602546548552;31441.37117257642;31515.36969260602;31973;32034.839825801188;32068.679313207034;1042.4162469017374;1076.860008198929;1081.4862940103544;1100.5047728522197;1198.2271434924598;15724.1709613205;16079.598010049842;16359.83640163607;16365.67268654644;16401.917990409973;459700;461197;463316;464109;474660;44160;53833;55170;55407;61212;1352.918824870511;1364.843043050042;1367.2616786934943;1381.6683995840926;1384.8961327900247;30268.560509681916;32394;32409.837950811037;32600.347993039533;32905.835470822494;50555.24167137422;51045.74477127591;51108.48891511037;51127.74436127795;51169;436456;437821;438352;438416;439445;39168;39790.801045995744;40179;40777.106747190526;40789.38815917823;46033.76983115063;46158.07683846237;47193.76403117963;47478.52521474741;48326.5167348322;38960.80519597497;40075.79962100171;40227.59772402239;40683;40691.7965410171;39782;40695.389569155894;40908.59091409048;41334.37998429966;41920.580794191665;39140.412893806046;40174;41218.58781412148;41249.38125928053;41255.7937210312;30160;35505;36825.63174368329;37395.62604373921;37939.24121517499;26796.330091747863;27614.339060492148;27672.308192295353;27764.861175693994;27877 09:51:54 INFO - PROCESS | 23871 | |2;jquery.html;376.59905152831476;377.3208225194649;390.65231943570217;393.1351027738973;400.83365403357607;14416.462402150704;14771.704565908676;17089.48731538056;19529;19572.31496897609;18510.25958961643;18581.44255672332;18876.716849247237;19105.331313404033;19219;5356.598255130862;5570.498655121039;5574.554035677156;5589.329280486348;5589.496945274925;4491.910161796762;5521.171824226358;5555.8888822223735;5566.749496272657;5580.553555715554;5425.37608175061;5567.053600887839;5568.554515638739;5569.944300556983;5571.804986825462;5232.215167724834;5349;5352.598555108382;5363.865903352428;5365.222042803811;4588.885277868047;4764.356811830393;4766.046790641851;4772.594329481998;4773.498782627808;22349.664755028687;22510.88744556267;22765.31704048881;22788.544229115323;22872;2260.6722025306403;2278.7037685100995;2353.4114472731007;2451.227863223079;2726.2775364528416;13228.537001205008;13833.654158646013;13873.514426995007;14467.71064578713;14650.926745366312;1787.177898166845;1811.5471132216946;1844.3452574336052;1885.5097674604565;1978.8515861310316;83442;83674.28560001605;84642.15357846404;84767.15232847654;85269;10369.222308326755;10485.895141048644;10884.346939183675;10918.235723499438;11483.36841473727;14928.402863885323;14953;14962.551123466314;14968.775468367983;14977.176255305845;7735.593421481947;8051.63767630458;8076.8384632307025;8268.214519620626;8339.499630022217;7505;7632.618369081635;7746.806329841799;7855.410844186595;7897.24976127267;6322.557420980487;6373.490120790326;6377.489800815923;6405.103285540028;6515.837104072341;1944.9416517504499;1952.9023548822502;1967.9212831486866;2010.145688082559;2022.6145090612977;902.3187493442409;948.5257371314343;968.2544440780559;972.6206779356057;1030.9278350515542;17221.7416738749;18892.33876814305;18915.337963171223;19053.42839714811;19201.967586806648;969.9418034917927;971.7173331202886;989.3766926836047;1017.9083882450615;1020.1532727835878;9943.80112397748;10633.415162166155;10700.518476668569;10850.620228291971;10854.185936054828;439172.40414497594;441559;445271;448880;449856;50252.748736256086;57679;82018.58990705009;82701;83560.58219708863;1007.9244056695777;1020.4795554267229;1029.6396261308632;1032.7056788815153;1040.152275895143;15864.76202856935;16334.101624410296;16504.17479126015;16854.241559129623;17326.826731732523;38642.6135738639;39742.40386394264;39852.800735996134;40129;40280.3957940637;51291;51770.223446649085;51881.48118518917;51971.740141300565;54300.185497218365;7911.406644501571;7970.601469926596;7980.441369104107;8069.798255043671;8488.660453582035;12753.61739147827;12978;13115.540956066492;13132.606021819362;13770;10908.672739817817;11207.159463040467;11303.321800691656;11415.486303116213;11495.712607184887;10864.674059778219;10921.617743378943;11062.115030797679;11227.101831853595;11357.318560886373;10827.729306767395;11103.444827758742;11171.608993685182;11418.600348987746;11639.883601164218;7762.632397118933;7978.640961156646;8114.904487894295;8209.302209312274;8234.464759790833;8259.752207433787;9941.950290248502;10459.320144190604;10545.57817687284;10854 09:51:54 INFO - PROCESS | 23871 | |3;mootools.html;1322;1443.9061461005033;1486.2865824404287;1579.510351790945;1744.3167343513514;7109.182444018939;7841.568713720743;8052.275295223429;8076.515409075452;8209.671613135468;8024.358051355892;8088.636011379487;8098.757037288876;8104.270615644591;8107.148749381318;2205.8676479411206;2233.4304752288144;2234.1175235781857;2240.798328150466;2241.23797908711;2138.967915481269;2157.0401171478698;2287.63397856343;2289.759575244592;2292.621717416624;2174.913003479867;2192.2875065603744;2204.1844517528457;2204.911803527857;2222.066731972567;2154.364462483571;2163.3185546552786;2183.1049269799387;2183.3995651195887;2184.85798423102;2131.861429007125;2190.1786829938774;2190.59473997311;2193.561287742442;2197.0662468450846;7964.2433968772875;8008.159143289929;8020.919790802134;8025.2777250047775;8205.876911846328;4870.561649451531;4977.552020318152;4986.401631804207;4987.850364489072;4992.475790042066;3221.3074189049466;3302.768806183568;3366.4781958796425;3377.392069427502;3378.256783507649;1119.7872404243167;1129.9661010169707;1131.0894729742554;1170.730731931652;1182.7457096724245;10894.237403381767;10964.780704385868;10983.39591322477;10988.340699557972;10999.560017599206;4006.979965100156;4262.786860656955;4304.849330273425;4320.395144679747;4344.847930322424;8850.070742572067;8889.066648001995;8897.73306800797;8899.955500222457;8910.688125915562;4928.01439712059;4943.678660887031;4945;4948.134076536592;4953.950460495421;3774.7735135891385;3941.881743547698;3985.1631157456677;4536.160810250114;4635.23518619424;3445;3460.186856088817;3547.6984456320984;3580.427131658922;3608.585012723518;1094.3652681444903;1095.3373209208473;1099.384344766933;1110.1451882050776;1110.4003837927428;867.5532100968006;884.9070847561043;888.6756333938196;902.6840605787921;930.688219446493;5191.351081114861;5198.220266959911;5268.367795864521;5319.148936170194;5375.3280839895015;408.2814246925433;418.0301700055902;421.6289665094697;437.3265171635646;441.66433510532227;3674.5223120994633;3687.391580389259;3703.9074023149096;3722.646348596879;3840.5391353037257;9140.634374625073;9210;9415.90584094164;9564.234861211087;9685.37045092081;9552.522373881278;9572.138507534355;9644.517774111266;9645.37305075168;9650.517474126265;7262.600556969312;7390.704371825067;7512.47412681118;7592.734254301073;7593.354564862048;5136.486351364833;5208.114620514446;5257.973710131425;5412.566994640498;5415.48552887475;8805.383623146574;8847.955760221157;8878.689245876363;8926;8965.686200982935;8355.791105222175;8928.86606700913;9073.319501037317;9115;9206.125418085272;6558.737650494118;6746.696398661974;6887.5178737487895;6898.620575868375;7014.859702806018;7708.961455192688;7723.304902558797;7744.8451030980195;7804.0635123785505;7807.960960195162;7068.823279418056;7075.929240707527;7084.539504932163;7085.326893945067;7104.183018952886;6822.420094292041;6884.931150688429;7046.295370462913;7066.399356054793;7079.964600176966;6451.258105317948;6542.738290468518;6557.704903279459;6560.606363618007;6564.310747371457;4550.908981820279;4613.538646135494;4651.627869770478;4688.320193571844;4879.341288926092;4659.4874563797275;4744.122337367598;4830.830920917751;4904.141775189399;4933.432655244693 09:51:54 INFO - PROCESS | 23871 | |4;prototype.html;307.9430305393501;314.47168756489094;323.622979229198;324.99187520311995;327.53326509723655;4927.753612319388;5072.72100034498;5161.45156453064;5173.301604283421;5217.660852044619;4647.790849411785;5110.948890511094;5111.4888511148865;5140.280360749498;5140.7172605506685;3969.6625786808154;3973.086190176261;3978.820953057112;3993.4409182714444;3994.0613955720382;3845.1348446599573;3916.3929590913453;3951.308521008826;3994.760314381132;4003.359462486003;3994.121293315466;3994.26106170358;3994.920101597966;4002.1195337025806;4004.4182547893565;4009.8797036088818;4010.3583426651594;4017.337139372;4030.4760381150263;4030.8186131624147;3566.7503274770775;3567.4470457079196;3568.411212149992;3598.5681718193982;3608.819559022065;5021.17150670139;5029.145045342264;5034.924476132861;5073.239014147871;5080.923786143211;4592.173408786417;4622;4623.768811559408;4624.213883639789;4628.352030715702;5367.516923476866;5374.5700343972385;5379.946200537984;5385.676859388449;5403.297571315743;3563.5901871284873;3785.337565925952;3797.886063418102;3819.866304679351;3828.578856325802;5236.3978142513715;5417.6478528895495;5493.862653433696;5519;5522.91715624266;3759.6992240620684;3886.125621735087;3890.3775395936514;3892.474515940312;3900.239453306578;3927.996721671968;3946.2502124596235;3953.2291203215095;3983.46223259862;4013.177298653769;4470.530594287618;4502.144592527409;4554.225781617133;4588.403507543998;4605.263157894721;5093.54158125763;5331.466853314638;5363.490468405495;5372.489613486712;5377.677339359651;1315.9077965288786;1321.4978308242805;1323.2788130468919;1323.6955500234808;1326.8009798530104;861.1689719420664;900.6625161634967;911.198145631853;931.0038259062873;942.3309450290234;4949.381327334083;4966.783138131109;5006.74966251686;5024.196128619404;5036.823711170092;5311.167647161723;5312.203169524525;5321.201819727072;5321.840344789663;5328.200769884471;4772.665913386029;4975.979924115548;5022.0163035600735;5048.5203905628905;5079.87300317495;2806.3545384561667;2809.7471227589617;2815.7606603438935;2818.746312831855;2824.5057115004793;5494.972525137428;5500.257465242141;5541.254504830966;5544.473275038865;5557.527610153183;5198.648351428656;5317.468253174651;5388.434214407431;5425.647332923348;5450.31871016123;5494.2857428534035;5533.972330138324;5556.222128901876;5557.749506361118;5562.86092847674;5265.368155821173;5266.34170728659;5331.734013044518;5366.302380690641;5366.731663416892;4978.800847966186;5212.9739351303;5223.373195216598;5240.764165612481;5251.317328747238;5468.234447177478;5471.37079235893;5489.533389661923;5578.37816226373;5631.352394474524;3891.357925942301;3904.2386734587617;3942.3692209246383;3942.5609652477215;3952.5256969163884;5548.306461692288;5550.69471179089;5557.472040156179;5558.777648893999;5569.359523654832;5085.821996230115;5330.387005494418;5346.97326513365;5387.865303367447;5436.537894278872;5323.201519772065;5325.201219817059;5327.174287985368;5342.916262657644;5356.464353564768;5314.840554783363;5314.937012597418;5327.203218310418;5350.689081175137;5382.946170538245;5108.84673459782;5287.339082614673;5390.299261096033;5392.35291764975;5398.1902714593125;5256.474352564713;5278.709670968134;5285.788568457218;5286.233496143114;5304.761285742228 09:51:54 INFO - PROCESS | 23871 | |5;yui.html;704.7110684619304;711.9537230080044;756.71623141322;800.9879851802227;812.3257696112228;14671;15303.770443443344;15316.081035137871;15718.764218536731;15720.37118515258;14981.700365992701;14990;15007.92496037521;15039.09765414076;15083.849161508382;670.9429698475635;686.8145600687811;764.1403421151191;788.4796034617153;792.1207459719707;778.3967425245452;789.3527307607735;798.6725442568548;800.2877439079195;800.7037396163428;836.7029704454923;839.4711331860949;840.0171798995191;840.1346612988632;840.1808236968936;701.6877489517116;711.9822004449878;835.1231207232381;835.6699103854005;836.1638361638331;592.7984485275027;598.775459202799;604.0335463258795;611.5932904618423;613.2487702564367;13542.729145417135;13573.52492662752;13574.796378054238;13575.389107490088;13579.117357371739;12826.871731282661;12957.935210323982;13179.538716144889;13183.670408239775;13263.204207747565;11789.233699809485;11978.161528692995;12038.277703337828;12149.453274602576;12270.92188697652;4180.853670121531;4213.199492096523;4250.53244143144;4302.397664326997;4323.286657701507;62275.377246227414;62537.061944070876;62828;63524.364756352305;64397;9952.751181220383;10160.237982151368;10167.796644067077;10257.17942564593;10273.383596984206;17099.572510687085;17151.65696686059;17293.913530432266;17301;17351;7508.849823003509;7733.4973226740085;7833.1775163608145;7909.24862138096;8056.758297251092;4409.36064270679;4520.977395113004;4526.79629416677;4602.792874320664;4659.440867095903;3124.265797537577;3211.197200699825;3220.0822765511716;3222.629397619257;3231.2891163943896;572.9828105156852;575.1143239411343;581.6451964301773;590.5600327755849;601.4797200421604;567.7218163100134;705.4074577355046;711.2851584157992;721.6031182849517;723.1947375199348;8080.737393529704;8605.569721514024;8699.521526316114;8814.250788682906;9043.559662995205;672.9663516824139;677.6336320271026;694.8818700820873;723.8479919216918;725.0538047847609;4012.197560487914;4220.2192594370135;4282.914341713148;4311.159323931804;4414.073044660593;88679;88690;88853.33599980027;89709.55145224232;90993;64719;75943;76817.61591192009;79828;79923.20076799273;58981;65470;65511.672441637485;66768.66615666987;66951.33048669451;8862.64549418016;8943.552822358726;9081.63673453081;9088.09119088086;9114.544272786467;42935.35596965985;45529.317060244786;46343.53656463392;46447.767761160976;47081.05837883155;59670;60340;60573;61785.569669611265;61840.69079654573;10817.945910270399;11898.405079746151;11992.520299187934;12094;12366.62900112998;13525.797113043116;13787.793183102462;13797.397112218901;14666.193359365338;14916.403343866124;11147.665570032912;11602.535898563963;12104;12225.694357640774;12960.611181664564;11582.768344633228;11754.412279386168;12705.745885082062;12882.162659427107;13090.54183103625;11233.32600044;11508.769824603629;11934.480489701542;11990.280583165038;12382.75234495287;8938.68714594986;10113.898861011296;10147.64483243083;10405.895941040493;10582.576696932036;10447.216458765775;10704.518296676513;10741;10901.509432075418;11087.813220313907 09:51:54 INFO - PROCESS | 23871 | __end_tp_report 09:51:54 INFO - PROCESS | 23871 | __start_cc_report 09:51:54 INFO - PROCESS | 23871 | _x_x_mozilla_cycle_collect,1360 09:51:54 INFO - PROCESS | 23871 | __end_cc_report 09:51:54 INFO - PROCESS | 23871 | __startTimestamp1479405114231__endTimestamp 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | ------- Summary: start ------- 09:51:54 INFO - PROCESS | 23871 | Number of tests: 6 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#0] dojo.html Cycles:165 Average:5231.96 Median:5456.48 stddev:579.40 (10.6%) stddev-sans-first:553.23 09:51:54 INFO - PROCESS | 23871 | Values: 2965.5 2974.8 2996.3 3032.9 3041.3 5208.8 5223.7 5289.7 5325.8 5329.3 5187.1 5254.2 5259.5 5298.8 5321.3 4730.2 4779.4 4809.5 4809.7 4863.2 4914.6 4925.4 4951.8 4969.3 5015.0 4761.3 4863.6 4865.9 4876.6 4957.3 4766.2 4780.1 4794.6 4817.7 4842.0 4789.2 4796.7 4797.4 4831.9 4854.9 5243.2 5276.9 5279.4 5289.2 5297.2 5498.2 5514.5 5540.6 5550.3 5620.8 5632.7 5638.2 5638.5 5670.8 5686.8 5243.2 5251.6 5252.2 5256.7 5302.4 5595.4 5632.8 5719.9 5736.2 5750.9 5528.1 5563.7 5569.4 5613.4 5613.9 5575.0 5589.3 5616.9 5631.4 5633.9 5402.4 5447.5 5589.0 5605.8 5618.1 5527.2 5536.9 5567.9 5606.8 5621.1 4305.8 4308.1 4351.6 4365.3 4404.8 3868.8 3871.0 3889.8 3898.4 3935.7 5245.6 5274.6 5361.8 5372.8 5413.2 5627.5 5628.9 5630.6 5646.5 5654.8 5187.7 5312.2 5323.3 5324.4 5370.1 4805.4 4829.1 4839.5 4845.0 4879.1 5804.9 5815.9 5818.3 5821.8 5822.8 5572.4 5579.5 5582.1 5589.1 5593.7 5704.8 5768.7 5778.7 5795.4 5824.3 5533.8 5533.8 5548.7 5577.0 5590.4 5582.9 5597.9 5635.1 5637.6 5640.8 5398.2 5416.9 5467.8 5512.3 5555.0 5430.7 5502.0 5506.7 5546.2 5552.3 5479.5 5484.9 5486.4 5490.1 5491.3 5466.5 5506.9 5533.4 5560.3 5617.4 5378.0 5453.7 5456.5 5500.8 5508.9 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#1] ext.html Cycles:180 Average:57271.65 Median:39154.21 stddev:108630.81 (277.4%) stddev-sans-first:108852.06 09:51:54 INFO - PROCESS | 23871 | Values: 545.8 584.7 591.0 593.5 594.3 32224.4 32974.8 41346.4 42209.6 42341.2 39833.2 42588.8 42596.0 42598.1 42640.6 7951.8 8652.6 8815.6 8818.6 8825.2 8102.1 10270.6 10473.4 10513.3 10847.4 10633.9 10656.1 10693.6 10708.8 10711.2 10488.3 10521.5 10537.5 10545.3 10551.0 10515.3 10559.8 10571.2 10581.3 10583.3 41568.4 41664.4 41981.6 42019.4 42037.6 3242.3 3277.7 3309.4 3365.6 3454.7 30451.1 31227.8 31230.8 31301.2 31580.2 4031.7 4163.4 4196.5 4244.2 4369.7 314444.0 315630.0 316169.0 316661.0 317145.0 57042.4 57588.7 57666.4 57669.4 57682.7 59780.4 59952.4 60320.4 60421.7 60576.4 16660.2 16842.2 16845.9 16847.9 16866.2 11560.8 11901.8 12778.6 13046.5 13159.7 17123.7 17173.2 17180.7 17183.4 17189.1 5551.5 6676.7 6751.5 6754.8 6851.7 951.6 991.5 1030.8 1078.8 1122.4 31441.4 31515.4 31973.0 32034.8 32068.7 1042.4 1076.9 1081.5 1100.5 1198.2 15724.2 16079.6 16359.8 16365.7 16401.9 459700.0 461197.0 463316.0 464109.0 474660.0 44160.0 53833.0 55170.0 55407.0 61212.0 1352.9 1364.8 1367.3 1381.7 1384.9 30268.6 32394.0 32409.8 32600.3 32905.8 50555.2 51045.7 51108.5 51127.7 51169.0 436456.0 437821.0 438352.0 438416.0 439445.0 39168.0 39790.8 40179.0 40777.1 40789.4 46033.8 46158.1 47193.8 47478.5 48326.5 38960.8 40075.8 40227.6 40683.0 40691.8 39782.0 40695.4 40908.6 41334.4 41920.6 39140.4 40174.0 41218.6 41249.4 41255.8 30160.0 35505.0 36825.6 37395.6 37939.2 26796.3 27614.3 27672.3 27764.9 27877.0 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#2] jquery.html Cycles:180 Average:26887.92 Median:376.96 stddev:73275.08 (19438.4%) stddev-sans-first:73453.59 09:51:54 INFO - PROCESS | 23871 | Values: 376.6 377.3 390.7 393.1 400.8 14416.5 14771.7 17089.5 19529.0 19572.3 18510.3 18581.4 18876.7 19105.3 19219.0 5356.6 5570.5 5574.6 5589.3 5589.5 4491.9 5521.2 5555.9 5566.7 5580.6 5425.4 5567.1 5568.6 5569.9 5571.8 5232.2 5349.0 5352.6 5363.9 5365.2 4588.9 4764.4 4766.0 4772.6 4773.5 22349.7 22510.9 22765.3 22788.5 22872.0 2260.7 2278.7 2353.4 2451.2 2726.3 13228.5 13833.7 13873.5 14467.7 14650.9 1787.2 1811.5 1844.3 1885.5 1978.9 83442.0 83674.3 84642.2 84767.2 85269.0 10369.2 10485.9 10884.3 10918.2 11483.4 14928.4 14953.0 14962.6 14968.8 14977.2 7735.6 8051.6 8076.8 8268.2 8339.5 7505.0 7632.6 7746.8 7855.4 7897.2 6322.6 6373.5 6377.5 6405.1 6515.8 1944.9 1952.9 1967.9 2010.1 2022.6 902.3 948.5 968.3 972.6 1030.9 17221.7 18892.3 18915.3 19053.4 19202.0 969.9 971.7 989.4 1017.9 1020.2 9943.8 10633.4 10700.5 10850.6 10854.2 439172.4 441559.0 445271.0 448880.0 449856.0 50252.7 57679.0 82018.6 82701.0 83560.6 1007.9 1020.5 1029.6 1032.7 1040.2 15864.8 16334.1 16504.2 16854.2 17326.8 38642.6 39742.4 39852.8 40129.0 40280.4 51291.0 51770.2 51881.5 51971.7 54300.2 7911.4 7970.6 7980.4 8069.8 8488.7 12753.6 12978.0 13115.5 13132.6 13770.0 10908.7 11207.2 11303.3 11415.5 11495.7 10864.7 10921.6 11062.1 11227.1 11357.3 10827.7 11103.4 11171.6 11418.6 11639.9 7762.6 7978.6 8114.9 8209.3 8234.5 8259.8 9942.0 10459.3 10545.6 10854.0 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#3] mootools.html Cycles:180 Average:5233.10 Median:4965.75 stddev:2906.26 (58.5%) stddev-sans-first:2899.55 09:51:54 INFO - PROCESS | 23871 | Values: 1322.0 1443.9 1486.3 1579.5 1744.3 7109.2 7841.6 8052.3 8076.5 8209.7 8024.4 8088.6 8098.8 8104.3 8107.1 2205.9 2233.4 2234.1 2240.8 2241.2 2139.0 2157.0 2287.6 2289.8 2292.6 2174.9 2192.3 2204.2 2204.9 2222.1 2154.4 2163.3 2183.1 2183.4 2184.9 2131.9 2190.2 2190.6 2193.6 2197.1 7964.2 8008.2 8020.9 8025.3 8205.9 4870.6 4977.6 4986.4 4987.9 4992.5 3221.3 3302.8 3366.5 3377.4 3378.3 1119.8 1130.0 1131.1 1170.7 1182.7 10894.2 10964.8 10983.4 10988.3 10999.6 4007.0 4262.8 4304.8 4320.4 4344.8 8850.1 8889.1 8897.7 8900.0 8910.7 4928.0 4943.7 4945.0 4948.1 4954.0 3774.8 3941.9 3985.2 4536.2 4635.2 3445.0 3460.2 3547.7 3580.4 3608.6 1094.4 1095.3 1099.4 1110.1 1110.4 867.6 884.9 888.7 902.7 930.7 5191.4 5198.2 5268.4 5319.1 5375.3 408.3 418.0 421.6 437.3 441.7 3674.5 3687.4 3703.9 3722.6 3840.5 9140.6 9210.0 9415.9 9564.2 9685.4 9552.5 9572.1 9644.5 9645.4 9650.5 7262.6 7390.7 7512.5 7592.7 7593.4 5136.5 5208.1 5258.0 5412.6 5415.5 8805.4 8848.0 8878.7 8926.0 8965.7 8355.8 8928.9 9073.3 9115.0 9206.1 6558.7 6746.7 6887.5 6898.6 7014.9 7709.0 7723.3 7744.8 7804.1 7808.0 7068.8 7075.9 7084.5 7085.3 7104.2 6822.4 6884.9 7046.3 7066.4 7080.0 6451.3 6542.7 6557.7 6560.6 6564.3 4550.9 4613.5 4651.6 4688.3 4879.3 4659.5 4744.1 4830.8 4904.1 4933.4 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#4] prototype.html Cycles:180 Average:4466.09 Median:5101.19 stddev:1303.75 (25.6%) stddev-sans-first:1269.50 09:51:54 INFO - PROCESS | 23871 | Values: 307.9 314.5 323.6 325.0 327.5 4927.8 5072.7 5161.5 5173.3 5217.7 4647.8 5110.9 5111.5 5140.3 5140.7 3969.7 3973.1 3978.8 3993.4 3994.1 3845.1 3916.4 3951.3 3994.8 4003.4 3994.1 3994.3 3994.9 4002.1 4004.4 4009.9 4010.4 4017.3 4030.5 4030.8 3566.8 3567.4 3568.4 3598.6 3608.8 5021.2 5029.1 5034.9 5073.2 5080.9 4592.2 4622.0 4623.8 4624.2 4628.4 5367.5 5374.6 5379.9 5385.7 5403.3 3563.6 3785.3 3797.9 3819.9 3828.6 5236.4 5417.6 5493.9 5519.0 5522.9 3759.7 3886.1 3890.4 3892.5 3900.2 3928.0 3946.3 3953.2 3983.5 4013.2 4470.5 4502.1 4554.2 4588.4 4605.3 5093.5 5331.5 5363.5 5372.5 5377.7 1315.9 1321.5 1323.3 1323.7 1326.8 861.2 900.7 911.2 931.0 942.3 4949.4 4966.8 5006.7 5024.2 5036.8 5311.2 5312.2 5321.2 5321.8 5328.2 4772.7 4976.0 5022.0 5048.5 5079.9 2806.4 2809.7 2815.8 2818.7 2824.5 5495.0 5500.3 5541.3 5544.5 5557.5 5198.6 5317.5 5388.4 5425.6 5450.3 5494.3 5534.0 5556.2 5557.7 5562.9 5265.4 5266.3 5331.7 5366.3 5366.7 4978.8 5213.0 5223.4 5240.8 5251.3 5468.2 5471.4 5489.5 5578.4 5631.4 3891.4 3904.2 3942.4 3942.6 3952.5 5548.3 5550.7 5557.5 5558.8 5569.4 5085.8 5330.4 5347.0 5387.9 5436.5 5323.2 5325.2 5327.2 5342.9 5356.5 5314.8 5314.9 5327.2 5350.7 5382.9 5108.8 5287.3 5390.3 5392.4 5398.2 5256.5 5278.7 5285.8 5286.2 5304.8 09:51:54 INFO - PROCESS | 23871 | 09:51:54 INFO - PROCESS | 23871 | [#5] yui.html Cycles:180 Average:17413.14 Median:25553.60 stddev:23290.00 (91.1%) stddev-sans-first:23321.55 09:51:54 INFO - PROCESS | 23871 | Values: 704.7 712.0 756.7 801.0 812.3 14671.0 15303.8 15316.1 15718.8 15720.4 14981.7 14990.0 15007.9 15039.1 15083.8 670.9 686.8 764.1 788.5 792.1 778.4 789.4 798.7 800.3 800.7 836.7 839.5 840.0 840.1 840.2 701.7 712.0 835.1 835.7 836.2 592.8 598.8 604.0 611.6 613.2 13542.7 13573.5 13574.8 13575.4 13579.1 12826.9 12957.9 13179.5 13183.7 13263.2 11789.2 11978.2 12038.3 12149.5 12270.9 4180.9 4213.2 4250.5 4302.4 4323.3 62275.4 62537.1 62828.0 63524.4 64397.0 9952.8 10160.2 10167.8 10257.2 10273.4 17099.6 17151.7 17293.9 17301.0 17351.0 7508.8 7733.5 7833.2 7909.2 8056.8 4409.4 4521.0 4526.8 4602.8 4659.4 3124.3 3211.2 3220.1 3222.6 3231.3 573.0 575.1 581.6 590.6 601.5 567.7 705.4 711.3 721.6 723.2 8080.7 8605.6 8699.5 8814.3 9043.6 673.0 677.6 694.9 723.8 725.1 4012.2 4220.2 4282.9 4311.2 4414.1 88679.0 88690.0 88853.3 89709.6 90993.0 64719.0 75943.0 76817.6 79828.0 79923.2 58981.0 65470.0 65511.7 66768.7 66951.3 8862.6 8943.6 9081.6 9088.1 9114.5 42935.4 45529.3 46343.5 46447.8 47081.1 59670.0 60340.0 60573.0 61785.6 61840.7 10817.9 11898.4 11992.5 12094.0 12366.6 13525.8 13787.8 13797.4 14666.2 14916.4 11147.7 11602.5 12104.0 12225.7 12960.6 11582.8 11754.4 12705.7 12882.2 13090.5 11233.3 11508.8 11934.5 11990.3 12382.8 8938.7 10113.9 10147.6 10405.9 10582.6 10447.2 10704.5 10741.0 10901.5 11087.8 09:51:54 INFO - PROCESS | 23871 | -------- Summary: end -------- 09:51:54 INFO - PROCESS | 23871 | 09:51:55 INFO - TEST-INFO | 23871: exit 0 09:51:55 INFO - TEST-OK | dromaeo_css | took 1118178ms 09:51:55 INFO - TEST-START | kraken 09:51:55 INFO - operating with platform_type : linux_ 09:51:55 INFO - Initialising browser for kraken test... 09:51:55 INFO - TEST-INFO | started process 24179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEYSxiL/profile http://localhost:37039/getInfo.html) 09:51:59 INFO - PROCESS | 24179 | __metrics Screen width/height:1600/1200 09:51:59 INFO - PROCESS | 24179 | colorDepth:24 09:51:59 INFO - PROCESS | 24179 | Browser inner width/height: 1024/697 09:51:59 INFO - PROCESS | 24179 | __metrics 09:51:59 INFO - PROCESS | 24179 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:51:59 INFO - PROCESS | 24179 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:00 INFO - PROCESS | 24179 | console.error: PushService: 09:52:00 INFO - PROCESS | 24179 | stateChangeProcessEnqueue: Error transitioning state 09:52:00 INFO - PROCESS | 24179 | UnknownError 09:52:01 INFO - TEST-INFO | 24179: exit 0 09:52:01 INFO - Browser initialized. 09:52:01 INFO - Running cycle 1/1 for kraken test... 09:52:01 INFO - TEST-INFO | started process 24261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEYSxiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:13 INFO - PROCESS | 24261 | RSS: Main: 173572096 09:52:13 INFO - PROCESS | 24261 | 09:52:15 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:16 INFO - PROCESS | 24261 | RSS: Main: 230666240 09:52:16 INFO - PROCESS | 24261 | 09:52:19 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-dft) 09:52:19 INFO - PROCESS | 24261 | RSS: Main: 217014272 09:52:19 INFO - PROCESS | 24261 | 09:52:23 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-fft) 09:52:23 INFO - PROCESS | 24261 | RSS: Main: 298078208 09:52:23 INFO - PROCESS | 24261 | 09:52:25 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-oscillator) 09:52:26 INFO - PROCESS | 24261 | RSS: Main: 207609856 09:52:26 INFO - PROCESS | 24261 | 09:52:28 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:29 INFO - PROCESS | 24261 | RSS: Main: 213196800 09:52:29 INFO - PROCESS | 24261 | 09:52:32 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:32 INFO - PROCESS | 24261 | RSS: Main: 253087744 09:52:32 INFO - PROCESS | 24261 | 09:52:36 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:36 INFO - PROCESS | 24261 | RSS: Main: 252518400 09:52:36 INFO - PROCESS | 24261 | 09:52:39 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37039/tests/kraken/driver.html?testName=json-parse-financial) 09:52:40 INFO - PROCESS | 24261 | RSS: Main: 251662336 09:52:40 INFO - PROCESS | 24261 | 09:52:41 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:42 INFO - PROCESS | 24261 | RSS: Main: 214343680 09:52:42 INFO - PROCESS | 24261 | 09:52:43 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:44 INFO - PROCESS | 24261 | RSS: Main: 221265920 09:52:44 INFO - PROCESS | 24261 | 09:52:46 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:47 INFO - PROCESS | 24261 | RSS: Main: 229883904 09:52:47 INFO - PROCESS | 24261 | 09:52:49 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:50 INFO - PROCESS | 24261 | RSS: Main: 238055424 09:52:50 INFO - PROCESS | 24261 | 09:52:53 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:53 INFO - PROCESS | 24261 | RSS: Main: 235450368 09:52:53 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37039/tests/kraken/driver.html?testName=ai-astar) 09:52:55 INFO - PROCESS | 24261 | RSS: Main: 285474816 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | __start_tp_report 09:52:55 INFO - PROCESS | 24261 | _x_x_mozilla_page_load 09:52:55 INFO - PROCESS | 24261 | _x_x_mozilla_page_load_details 09:52:55 INFO - PROCESS | 24261 | |i|pagename|runs| 09:52:55 INFO - PROCESS | 24261 | |0;ai-astar;105;115;112;110;112;113;113;114;114;112 09:52:55 INFO - PROCESS | 24261 | |1;audio-beat-detection;146;122;123;173;129;124;127;126;158;129 09:52:55 INFO - PROCESS | 24261 | |2;audio-dft;161;160;160;161;159;161;161;162;163;164 09:52:55 INFO - PROCESS | 24261 | |3;audio-fft;76;76;75;116;77;78;76;78;99;75 09:52:55 INFO - PROCESS | 24261 | |4;audio-oscillator;82;83;108;83;83;83;100;82;82;114 09:52:55 INFO - PROCESS | 24261 | |5;imaging-gaussian-blur;117;116;117;116;116;117;117;116;117;117 09:52:55 INFO - PROCESS | 24261 | |6;imaging-darkroom;146;146;147;148;146;147;146;147;146;147 09:52:55 INFO - PROCESS | 24261 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;95;95 09:52:55 INFO - PROCESS | 24261 | |8;json-parse-financial;53;50;51;50;52;52;52;52;52;55 09:52:55 INFO - PROCESS | 24261 | |9;json-stringify-tinderbox;62;62;62;62;62;61;63;63;67;63 09:52:55 INFO - PROCESS | 24261 | |10;stanford-crypto-aes;88;83;85;78;81;79;79;89;79;80 09:52:55 INFO - PROCESS | 24261 | |11;stanford-crypto-ccm;134;131;133;132;137;132;132;135;190;142 09:52:55 INFO - PROCESS | 24261 | |12;stanford-crypto-pbkdf2;167;164;164;171;171;171;167;165;165;163 09:52:55 INFO - PROCESS | 24261 | |13;stanford-crypto-sha256-iterative;64;65;64;67;65;64;71;64;62;67 09:52:55 INFO - PROCESS | 24261 | __end_tp_report 09:52:55 INFO - PROCESS | 24261 | __start_cc_report 09:52:55 INFO - PROCESS | 24261 | _x_x_mozilla_cycle_collect,1665 09:52:55 INFO - PROCESS | 24261 | __end_cc_report 09:52:55 INFO - PROCESS | 24261 | __startTimestamp1479405175862__endTimestamp 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | ------- Summary: start ------- 09:52:55 INFO - PROCESS | 24261 | Number of tests: 14 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.83 (2.5%) stddev-sans-first:1.48 09:52:55 INFO - PROCESS | 24261 | Values: 105.0 115.0 112.0 110.0 112.0 113.0 113.0 114.0 114.0 112.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.00 stddev:17.45 (13.5%) stddev-sans-first:18.10 09:52:55 INFO - PROCESS | 24261 | Values: 146.0 122.0 123.0 173.0 129.0 124.0 127.0 126.0 158.0 129.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 09:52:55 INFO - PROCESS | 24261 | Values: 161.0 160.0 160.0 161.0 159.0 161.0 161.0 162.0 163.0 164.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:13.76 (18.0%) stddev-sans-first:14.39 09:52:55 INFO - PROCESS | 24261 | Values: 76.0 76.0 75.0 116.0 77.0 78.0 76.0 78.0 99.0 75.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.50 stddev:12.42 (15.1%) stddev-sans-first:12.83 09:52:55 INFO - PROCESS | 24261 | Values: 82.0 83.0 108.0 83.0 83.0 83.0 100.0 82.0 82.0 114.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:52:55 INFO - PROCESS | 24261 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:52:55 INFO - PROCESS | 24261 | Values: 146.0 146.0 147.0 148.0 146.0 147.0 146.0 147.0 146.0 147.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:52:55 INFO - PROCESS | 24261 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.45 (2.8%) stddev-sans-first:1.48 09:52:55 INFO - PROCESS | 24261 | Values: 53.0 50.0 51.0 50.0 52.0 52.0 52.0 52.0 52.0 55.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.64 (2.6%) stddev-sans-first:1.72 09:52:55 INFO - PROCESS | 24261 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 63.0 63.0 67.0 63.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:3.98 (4.9%) stddev-sans-first:3.61 09:52:55 INFO - PROCESS | 24261 | Values: 88.0 83.0 85.0 78.0 81.0 79.0 79.0 89.0 79.0 80.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:134.50 stddev:17.94 (13.3%) stddev-sans-first:18.90 09:52:55 INFO - PROCESS | 24261 | Values: 134.0 131.0 133.0 132.0 137.0 132.0 132.0 135.0 190.0 142.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:3.16 (1.9%) stddev-sans-first:3.35 09:52:55 INFO - PROCESS | 24261 | Values: 167.0 164.0 164.0 171.0 171.0 171.0 167.0 165.0 165.0 163.0 09:52:55 INFO - PROCESS | 24261 | 09:52:55 INFO - PROCESS | 24261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.50 (3.8%) stddev-sans-first:2.60 09:52:55 INFO - PROCESS | 24261 | Values: 64.0 65.0 64.0 67.0 65.0 64.0 71.0 64.0 62.0 67.0 09:52:55 INFO - PROCESS | 24261 | -------- Summary: end -------- 09:52:55 INFO - PROCESS | 24261 | 09:52:57 INFO - TEST-INFO | 24261: exit 0 09:52:57 INFO - TEST-OK | kraken | took 62040ms 09:52:57 INFO - SUITE-END | took 1180s 09:52:57 INFO - Completed test suite (00:19:40) 09:52:57 INFO - javascript benchmark 09:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2965.5255159174535, 2974.8363839988792, 2996.2808925857803, 3032.8938487152955, 3041.254892551325, 5208.8437346879655, 5223.738813059351, 5289.656172348795, 5325.840224793253, 5329.280547126142, 5187.144121220003, 5254.211868219769, 5259.526642602165, 5298.841034768953, 5321.281626980356, 4730.243161094226, 4779.354787103749, 4809.51904809518, 4809.735464549449, 4863.1732605457155, 4914.582260507861, 4925.408950925894, 4951.752412379366, 4969.304297398367, 5014.974925125369, 4761.333413322138, 4863.635227357962, 4865.9026819463415, 4876.585490233334, 4957.330760347361, 4766.165920963852, 4780.11567859947, 4794.616430685537, 4817.735024573647, 4841.975790121062, 4789.161896668104, 4796.688215265996, 4797.424309082898, 4831.879203019917, 4854.878628034292, 5243.187305967581, 5276.868078298035, 5279.366476022863, 5289.206619007141, 5297.17893726473, 5498.1752737089755, 5514.531264842493, 5540.63985840919, 5550.27846379972, 5620.803271885465, 5632.718364081779, 5638.182463542763, 5638.520725738317, 5670.829875103754, 5686.800961966312, 5243.187305967581, 5251.579873610141, 5252.23842542833, 5256.658317209369, 5302.443243459458, 5595.4124816894455, 5632.7746890123935, 5719.914201286984, 5736.196932429463, 5750.856228594319, 5528.06022976095, 5563.693996830213, 5569.387367389584, 5613.410591887875, 5613.859653508695, 5574.9721251393485, 5589.301337332833, 5616.943830561724, 5631.4087020863035, 5633.887322253532, 5402.432744561765, 5447.4552544746, 5589.0, 5605.831825045255, 5618.101103823368, 5527.226188333637, 5536.916946245729, 5567.860803479864, 5606.803761868315, 5621.072523033654, 4305.84929527465, 4308.073764140725, 4351.608355248043, 4365.301551751704, 4404.8458303959205, 3868.825902834379, 3871.0, 3889.766614003169, 3898.3957486589625, 3935.665468435158, 5245.632805703564, 5274.604404669665, 5361.812336568201, 5372.838814835483, 5413.2150838128255, 5627.493525582717, 5628.859278517988, 5630.577706672016, 5646.463585959327, 5654.802081927113, 5187.662801917863, 5312.2297266896085, 5323.254744335796, 5324.41431442541, 5370.1407774756635, 4805.399325084364, 4829.106615276185, 4839.491853355347, 4845.0, 4879.097366987119, 5804.9419505805245, 5815.912761308499, 5818.33089194748, 5821.825345239734, 5822.82531524055, 5572.442755724395, 5579.525740312119, 5582.106862901916, 5589.07780216276, 5593.748281327269, 5704.828855134187, 5768.653880767168, 5778.653280803165, 5795.420457954171, 5824.271966004249, 5533.806316778893, 5533.806316778893, 5548.667079975215, 5577.0, 5590.413006634408, 5582.86042848932, 5597.944020559905, 5635.0702134147405, 5637.646964728354, 5640.830775076754, 5398.1902714593125, 5416.864578385572, 5467.808626698046, 5512.2558454608115, 5555.0, 5430.70131142791, 5501.972490137684, 5506.669599824023, 5546.168074788814, 5552.333719953632, 5479.53423958968, 5484.917726234189, 5486.369067557122, 5490.149026900836, 5491.313585801775, 5466.480684334982, 5506.862328441821, 5533.418991005887, 5560.277163968658, 5617.43825617435, 5378.0, 5453.672779633234, 5456.48163424474, 5500.779968801203, 5508.91736623943], "value": 5193.105553256911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.8281803557645, 584.6755050946724, 591.0189086117044, 593.5370411079359, 594.2838879150623, 32224.355512889757, 32974.835125824364, 41346.37980430296, 42209.57790422095, 42341.153176936445, 39833.20333593326, 42588.78705606476, 42596.0, 42598.14803703924, 42640.573594264046, 7951.761447156566, 8652.567371631425, 8815.603297851612, 8818.603162857687, 8825.249853762438, 8102.108768035541, 10270.589176432934, 10473.423961682105, 10513.264071514997, 10847.403392813392, 10633.946830265837, 10656.094231990252, 10693.625723099693, 10708.839367409495, 10711.196660250473, 10488.265821392506, 10521.473926303654, 10537.525811338432, 10545.261831671785, 10551.0, 10515.316504427188, 10559.841602375971, 10571.154307655446, 10581.31221470602, 10583.259171857973, 41568.37647435291, 41664.375034374505, 41981.58018419807, 42019.36970945408, 42037.57962420398, 3242.3191129862757, 3277.6886195811358, 3309.4373956427467, 3365.5793025871767, 3454.671806178409, 30451.13901434301, 31227.843860780777, 31230.843845780626, 31301.217469563217, 31580.210494737585, 4031.677465802758, 4163.417121602978, 4196.454460920091, 4244.214820258262, 4369.71596846204, 314444.0, 315629.99999999773, 316169.0, 316661.0, 317145.0, 57042.42957570454, 57588.71205643945, 57666.42333576694, 57669.4233057664, 57682.7115864418, 59780.40219597836, 59952.400475994684, 60320.39679603148, 60421.69789151026, 60576.39423605796, 16660.16699165037, 16842.157892105344, 16845.91577042107, 16847.915760421365, 16866.241019154168, 11560.76878462426, 11901.821472677917, 12778.552750653682, 13046.47814087445, 13159.736805263841, 17123.65752684964, 17173.227204775816, 17180.735660224516, 17183.3985810496, 17189.1405429728, 5551.500364967173, 6676.732930682719, 6751.493637977172, 6754.76358327466, 6851.657417129223, 951.5622813505727, 991.4893829677721, 1030.7577719235974, 1078.7755897056898, 1122.3602546548552, 31441.37117257642, 31515.36969260602, 31973.0, 32034.839825801188, 32068.679313207034, 1042.4162469017374, 1076.860008198929, 1081.4862940103544, 1100.5047728522197, 1198.2271434924598, 15724.1709613205, 16079.598010049842, 16359.83640163607, 16365.67268654644, 16401.917990409973, 459700.0, 461197.0, 463316.0, 464109.0, 474660.0, 44160.0, 53833.0, 55170.0, 55407.0, 61212.0, 1352.918824870511, 1364.843043050042, 1367.2616786934943, 1381.6683995840926, 1384.8961327900247, 30268.560509681916, 32394.0, 32409.837950811037, 32600.347993039533, 32905.835470822494, 50555.24167137422, 51045.74477127591, 51108.48891511037, 51127.74436127795, 51169.0, 436456.0, 437821.0, 438352.0, 438416.0, 439445.0, 39168.0, 39790.801045995744, 40179.0, 40777.106747190526, 40789.38815917823, 46033.76983115063, 46158.07683846237, 47193.76403117963, 47478.52521474741, 48326.5167348322, 38960.80519597497, 40075.79962100171, 40227.59772402239, 40683.0, 40691.7965410171, 39782.0, 40695.389569155894, 40908.59091409048, 41334.37998429966, 41920.580794191665, 39140.412893806046, 40174.0, 41218.58781412148, 41249.38125928053, 41255.7937210312, 30160.0, 35505.0, 36825.63174368329, 37395.62604373921, 37939.24121517499, 26796.330091747863, 27614.339060492148, 27672.308192295353, 27764.861175693994, 27877.0], "value": 20089.379705802818, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.59905152831476, 377.3208225194649, 390.65231943570217, 393.1351027738973, 400.83365403357607, 14416.462402150704, 14771.704565908676, 17089.48731538056, 19529.0, 19572.31496897609, 18510.25958961643, 18581.44255672332, 18876.716849247237, 19105.331313404033, 19219.0, 5356.598255130862, 5570.498655121039, 5574.554035677156, 5589.329280486348, 5589.496945274925, 4491.910161796762, 5521.171824226358, 5555.8888822223735, 5566.749496272657, 5580.553555715554, 5425.37608175061, 5567.053600887839, 5568.554515638739, 5569.944300556983, 5571.804986825462, 5232.215167724834, 5349.0, 5352.598555108382, 5363.865903352428, 5365.222042803811, 4588.885277868047, 4764.356811830393, 4766.046790641851, 4772.594329481998, 4773.498782627808, 22349.664755028687, 22510.88744556267, 22765.31704048881, 22788.544229115323, 22872.0, 2260.6722025306403, 2278.7037685100995, 2353.4114472731007, 2451.227863223079, 2726.2775364528416, 13228.537001205008, 13833.654158646013, 13873.514426995007, 14467.71064578713, 14650.926745366312, 1787.177898166845, 1811.5471132216946, 1844.3452574336052, 1885.5097674604565, 1978.8515861310316, 83442.0, 83674.28560001605, 84642.15357846404, 84767.15232847654, 85269.0, 10369.222308326755, 10485.895141048644, 10884.346939183675, 10918.235723499438, 11483.36841473727, 14928.402863885323, 14953.0, 14962.551123466314, 14968.775468367983, 14977.176255305845, 7735.593421481947, 8051.63767630458, 8076.8384632307025, 8268.214519620626, 8339.499630022217, 7505.0, 7632.618369081635, 7746.806329841799, 7855.410844186595, 7897.24976127267, 6322.557420980487, 6373.490120790326, 6377.489800815923, 6405.103285540028, 6515.837104072341, 1944.9416517504499, 1952.9023548822502, 1967.9212831486866, 2010.145688082559, 2022.6145090612977, 902.3187493442409, 948.5257371314343, 968.2544440780559, 972.6206779356057, 1030.9278350515542, 17221.7416738749, 18892.33876814305, 18915.337963171223, 19053.42839714811, 19201.967586806648, 969.9418034917927, 971.7173331202886, 989.3766926836047, 1017.9083882450615, 1020.1532727835878, 9943.80112397748, 10633.415162166155, 10700.518476668569, 10850.620228291971, 10854.185936054828, 439172.40414497594, 441559.0, 445271.0, 448880.0, 449856.0, 50252.748736256086, 57679.0, 82018.58990705009, 82701.0, 83560.58219708863, 1007.9244056695777, 1020.4795554267229, 1029.6396261308632, 1032.7056788815153, 1040.152275895143, 15864.76202856935, 16334.101624410296, 16504.17479126015, 16854.241559129623, 17326.826731732523, 38642.6135738639, 39742.40386394264, 39852.800735996134, 40129.0, 40280.3957940637, 51291.0, 51770.223446649085, 51881.48118518917, 51971.740141300565, 54300.185497218365, 7911.406644501571, 7970.601469926596, 7980.441369104107, 8069.798255043671, 8488.660453582035, 12753.61739147827, 12978.0, 13115.540956066492, 13132.606021819362, 13770.0, 10908.672739817817, 11207.159463040467, 11303.321800691656, 11415.486303116213, 11495.712607184887, 10864.674059778219, 10921.617743378943, 11062.115030797679, 11227.101831853595, 11357.318560886373, 10827.729306767395, 11103.444827758742, 11171.608993685182, 11418.600348987746, 11639.883601164218, 7762.632397118933, 7978.640961156646, 8114.904487894295, 8209.302209312274, 8234.464759790833, 8259.752207433787, 9941.950290248502, 10459.320144190604, 10545.57817687284, 10854.0], "value": 8976.179610423216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.0, 1443.9061461005033, 1486.2865824404287, 1579.510351790945, 1744.3167343513514, 7109.182444018939, 7841.568713720743, 8052.275295223429, 8076.515409075452, 8209.671613135468, 8024.358051355892, 8088.636011379487, 8098.757037288876, 8104.270615644591, 8107.148749381318, 2205.8676479411206, 2233.4304752288144, 2234.1175235781857, 2240.798328150466, 2241.23797908711, 2138.967915481269, 2157.0401171478698, 2287.63397856343, 2289.759575244592, 2292.621717416624, 2174.913003479867, 2192.2875065603744, 2204.1844517528457, 2204.911803527857, 2222.066731972567, 2154.364462483571, 2163.3185546552786, 2183.1049269799387, 2183.3995651195887, 2184.85798423102, 2131.861429007125, 2190.1786829938774, 2190.59473997311, 2193.561287742442, 2197.0662468450846, 7964.2433968772875, 8008.159143289929, 8020.919790802134, 8025.2777250047775, 8205.876911846328, 4870.561649451531, 4977.552020318152, 4986.401631804207, 4987.850364489072, 4992.475790042066, 3221.3074189049466, 3302.768806183568, 3366.4781958796425, 3377.392069427502, 3378.256783507649, 1119.7872404243167, 1129.9661010169707, 1131.0894729742554, 1170.730731931652, 1182.7457096724245, 10894.237403381767, 10964.780704385868, 10983.39591322477, 10988.340699557972, 10999.560017599206, 4006.979965100156, 4262.786860656955, 4304.849330273425, 4320.395144679747, 4344.847930322424, 8850.070742572067, 8889.066648001995, 8897.73306800797, 8899.955500222457, 8910.688125915562, 4928.01439712059, 4943.678660887031, 4945.0, 4948.134076536592, 4953.950460495421, 3774.7735135891385, 3941.881743547698, 3985.1631157456677, 4536.160810250114, 4635.23518619424, 3445.0, 3460.186856088817, 3547.6984456320984, 3580.427131658922, 3608.585012723518, 1094.3652681444903, 1095.3373209208473, 1099.384344766933, 1110.1451882050776, 1110.4003837927428, 867.5532100968006, 884.9070847561043, 888.6756333938196, 902.6840605787921, 930.688219446493, 5191.351081114861, 5198.220266959911, 5268.367795864521, 5319.148936170194, 5375.3280839895015, 408.2814246925433, 418.0301700055902, 421.6289665094697, 437.3265171635646, 441.66433510532227, 3674.5223120994633, 3687.391580389259, 3703.9074023149096, 3722.646348596879, 3840.5391353037257, 9140.634374625073, 9210.0, 9415.90584094164, 9564.234861211087, 9685.37045092081, 9552.522373881278, 9572.138507534355, 9644.517774111266, 9645.37305075168, 9650.517474126265, 7262.600556969312, 7390.704371825067, 7512.47412681118, 7592.734254301073, 7593.354564862048, 5136.486351364833, 5208.114620514446, 5257.973710131425, 5412.566994640498, 5415.48552887475, 8805.383623146574, 8847.955760221157, 8878.689245876363, 8926.0, 8965.686200982935, 8355.791105222175, 8928.86606700913, 9073.319501037317, 9115.0, 9206.125418085272, 6558.737650494118, 6746.696398661974, 6887.5178737487895, 6898.620575868375, 7014.859702806018, 7708.961455192688, 7723.304902558797, 7744.8451030980195, 7804.0635123785505, 7807.960960195162, 7068.823279418056, 7075.929240707527, 7084.539504932163, 7085.326893945067, 7104.183018952886, 6822.420094292041, 6884.931150688429, 7046.295370462913, 7066.399356054793, 7079.964600176966, 6451.258105317948, 6542.738290468518, 6557.704903279459, 6560.606363618007, 6564.310747371457, 4550.908981820279, 4613.538646135494, 4651.627869770478, 4688.320193571844, 4879.341288926092, 4659.4874563797275, 4744.122337367598, 4830.830920917751, 4904.141775189399, 4933.432655244693], "value": 4167.864360861287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.9430305393501, 314.47168756489094, 323.622979229198, 324.99187520311995, 327.53326509723655, 4927.753612319388, 5072.72100034498, 5161.45156453064, 5173.301604283421, 5217.660852044619, 4647.790849411785, 5110.948890511094, 5111.4888511148865, 5140.280360749498, 5140.7172605506685, 3969.6625786808154, 3973.086190176261, 3978.820953057112, 3993.4409182714444, 3994.0613955720382, 3845.1348446599573, 3916.3929590913453, 3951.308521008826, 3994.760314381132, 4003.359462486003, 3994.121293315466, 3994.26106170358, 3994.920101597966, 4002.1195337025806, 4004.4182547893565, 4009.8797036088818, 4010.3583426651594, 4017.337139372, 4030.4760381150263, 4030.8186131624147, 3566.7503274770775, 3567.4470457079196, 3568.411212149992, 3598.5681718193982, 3608.819559022065, 5021.17150670139, 5029.145045342264, 5034.924476132861, 5073.239014147871, 5080.923786143211, 4592.173408786417, 4622.0, 4623.768811559408, 4624.213883639789, 4628.352030715702, 5367.516923476866, 5374.5700343972385, 5379.946200537984, 5385.676859388449, 5403.297571315743, 3563.5901871284873, 3785.337565925952, 3797.886063418102, 3819.866304679351, 3828.578856325802, 5236.3978142513715, 5417.6478528895495, 5493.862653433696, 5519.0, 5522.91715624266, 3759.6992240620684, 3886.125621735087, 3890.3775395936514, 3892.474515940312, 3900.239453306578, 3927.996721671968, 3946.2502124596235, 3953.2291203215095, 3983.46223259862, 4013.177298653769, 4470.530594287618, 4502.144592527409, 4554.225781617133, 4588.403507543998, 4605.263157894721, 5093.54158125763, 5331.466853314638, 5363.490468405495, 5372.489613486712, 5377.677339359651, 1315.9077965288786, 1321.4978308242805, 1323.2788130468919, 1323.6955500234808, 1326.8009798530104, 861.1689719420664, 900.6625161634967, 911.198145631853, 931.0038259062873, 942.3309450290234, 4949.381327334083, 4966.783138131109, 5006.74966251686, 5024.196128619404, 5036.823711170092, 5311.167647161723, 5312.203169524525, 5321.201819727072, 5321.840344789663, 5328.200769884471, 4772.665913386029, 4975.979924115548, 5022.0163035600735, 5048.5203905628905, 5079.87300317495, 2806.3545384561667, 2809.7471227589617, 2815.7606603438935, 2818.746312831855, 2824.5057115004793, 5494.972525137428, 5500.257465242141, 5541.254504830966, 5544.473275038865, 5557.527610153183, 5198.648351428656, 5317.468253174651, 5388.434214407431, 5425.647332923348, 5450.31871016123, 5494.2857428534035, 5533.972330138324, 5556.222128901876, 5557.749506361118, 5562.86092847674, 5265.368155821173, 5266.34170728659, 5331.734013044518, 5366.302380690641, 5366.731663416892, 4978.800847966186, 5212.9739351303, 5223.373195216598, 5240.764165612481, 5251.317328747238, 5468.234447177478, 5471.37079235893, 5489.533389661923, 5578.37816226373, 5631.352394474524, 3891.357925942301, 3904.2386734587617, 3942.3692209246383, 3942.5609652477215, 3952.5256969163884, 5548.306461692288, 5550.69471179089, 5557.472040156179, 5558.777648893999, 5569.359523654832, 5085.821996230115, 5330.387005494418, 5346.97326513365, 5387.865303367447, 5436.537894278872, 5323.201519772065, 5325.201219817059, 5327.174287985368, 5342.916262657644, 5356.464353564768, 5314.840554783363, 5314.937012597418, 5327.203218310418, 5350.689081175137, 5382.946170538245, 5108.84673459782, 5287.339082614673, 5390.299261096033, 5392.35291764975, 5398.1902714593125, 5256.474352564713, 5278.709670968134, 5285.788568457218, 5286.233496143114, 5304.761285742228], "value": 4049.2657743944646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7110684619304, 711.9537230080044, 756.71623141322, 800.9879851802227, 812.3257696112228, 14671.0, 15303.770443443344, 15316.081035137871, 15718.764218536731, 15720.37118515258, 14981.700365992701, 14990.0, 15007.92496037521, 15039.09765414076, 15083.849161508382, 670.9429698475635, 686.8145600687811, 764.1403421151191, 788.4796034617153, 792.1207459719707, 778.3967425245452, 789.3527307607735, 798.6725442568548, 800.2877439079195, 800.7037396163428, 836.7029704454923, 839.4711331860949, 840.0171798995191, 840.1346612988632, 840.1808236968936, 701.6877489517116, 711.9822004449878, 835.1231207232381, 835.6699103854005, 836.1638361638331, 592.7984485275027, 598.775459202799, 604.0335463258795, 611.5932904618423, 613.2487702564367, 13542.729145417135, 13573.52492662752, 13574.796378054238, 13575.389107490088, 13579.117357371739, 12826.871731282661, 12957.935210323982, 13179.538716144889, 13183.670408239775, 13263.204207747565, 11789.233699809485, 11978.161528692995, 12038.277703337828, 12149.453274602576, 12270.92188697652, 4180.853670121531, 4213.199492096523, 4250.53244143144, 4302.397664326997, 4323.286657701507, 62275.377246227414, 62537.061944070876, 62828.0, 63524.364756352305, 64397.0, 9952.751181220383, 10160.237982151368, 10167.796644067077, 10257.17942564593, 10273.383596984206, 17099.572510687085, 17151.65696686059, 17293.913530432266, 17301.0, 17351.0, 7508.849823003509, 7733.4973226740085, 7833.1775163608145, 7909.24862138096, 8056.758297251092, 4409.36064270679, 4520.977395113004, 4526.79629416677, 4602.792874320664, 4659.440867095903, 3124.265797537577, 3211.197200699825, 3220.0822765511716, 3222.629397619257, 3231.2891163943896, 572.9828105156852, 575.1143239411343, 581.6451964301773, 590.5600327755849, 601.4797200421604, 567.7218163100134, 705.4074577355046, 711.2851584157992, 721.6031182849517, 723.1947375199348, 8080.737393529704, 8605.569721514024, 8699.521526316114, 8814.250788682906, 9043.559662995205, 672.9663516824139, 677.6336320271026, 694.8818700820873, 723.8479919216918, 725.0538047847609, 4012.197560487914, 4220.2192594370135, 4282.914341713148, 4311.159323931804, 4414.073044660593, 88679.0, 88690.0, 88853.33599980027, 89709.55145224232, 90993.0, 64719.0, 75943.0, 76817.61591192009, 79828.0, 79923.20076799273, 58981.0, 65470.0, 65511.672441637485, 66768.66615666987, 66951.33048669451, 8862.64549418016, 8943.552822358726, 9081.63673453081, 9088.09119088086, 9114.544272786467, 42935.35596965985, 45529.317060244786, 46343.53656463392, 46447.767761160976, 47081.05837883155, 59670.0, 60340.0, 60573.0, 61785.569669611265, 61840.69079654573, 10817.945910270399, 11898.405079746151, 11992.520299187934, 12094.0, 12366.62900112998, 13525.797113043116, 13787.793183102462, 13797.397112218901, 14666.193359365338, 14916.403343866124, 11147.665570032912, 11602.535898563963, 12104.0, 12225.694357640774, 12960.611181664564, 11582.768344633228, 11754.412279386168, 12705.745885082062, 12882.162659427107, 13090.54183103625, 11233.32600044, 11508.769824603629, 11934.480489701542, 11990.280583165038, 12382.75234495287, 8938.68714594986, 10113.898861011296, 10147.64483243083, 10405.895941040493, 10582.576696932036, 10447.216458765775, 10704.518296676513, 10741.0, 10901.509432075418, 11087.813220313907], "value": 6912.549944472477, "unit": "score"}], "name": "dromaeo_css", "value": 6914.233838454331, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 112.0, 110.0, 112.0, 113.0, 113.0, 114.0, 114.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 123.0, 173.0, 129.0, 124.0, 127.0, 126.0, 158.0, 129.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 159.0, 161.0, 161.0, 162.0, 163.0, 164.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 116.0, 77.0, 78.0, 76.0, 78.0, 99.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 83.0, 83.0, 83.0, 100.0, 82.0, 82.0, 114.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 50.0, 52.0, 52.0, 52.0, 52.0, 52.0, 55.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 63.0, 63.0, 67.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 85.0, 78.0, 81.0, 79.0, 79.0, 89.0, 79.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 133.0, 132.0, 137.0, 132.0, 132.0, 135.0, 190.0, 142.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 164.0, 171.0, 171.0, 171.0, 167.0, 165.0, 165.0, 163.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 67.0, 65.0, 64.0, 71.0, 64.0, 62.0, 67.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1508.7999999999997, "alertThreshold": 2.0}]} 09:52:57 INFO - Return code: 0 09:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:57 INFO - # TBPL SUCCESS # 09:52:57 INFO - Running post-action listener: _resource_record_post_action 09:52:57 INFO - [mozharness: 2016-11-17 17:52:57.672278Z] Finished run-tests step (success) 09:52:57 INFO - Running post-run listener: _resource_record_post_run 09:52:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 392495104; Read time: 492; Write time: 444968 09:52:57 INFO - TinderboxPrint: CPU usage
13.1% 09:52:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 492 09:52:57 INFO - TinderboxPrint: I/O write bytes / time
392,495,104 / 444,968 09:52:57 INFO - TinderboxPrint: CPU idle
8,308.7 (86.9%) 09:52:57 INFO - TinderboxPrint: CPU user
1,196.8 (12.5%) 09:52:57 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103559168; Read time: 0; Write time: 130476 09:52:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288935936; Read time: 476; Write time: 314492 09:52:58 INFO - Running post-run listener: _upload_blobber_files 09:52:58 INFO - Blob upload gear active. 09:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:58 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 09:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:02 INFO - (blobuploader) - INFO - Done attempting. 09:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:02 INFO - (blobuploader) - INFO - Done attempting. 09:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:03 INFO - (blobuploader) - INFO - Done attempting. 09:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:03 INFO - Return code: 0 09:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eab7988e0d0983c0e3c368558f07bae6437942e47ca2c58737e405cebcf6e54dcfbc11fb19a1cc279619214601f9337531727a08668b441cf7fb9885d8959d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/747750a05c3029f84aba0c5881cf365c69f0cfc39dcbd7e7e7766b902e301602748797fc873c918d40d0ebc2f722fdb130fb62f1e2218819a5898d29faf280b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/915f796df0c49a5f231d2d7d5c293133537c67f1a42dbf724dfc6f9d58a5e4d26f6f0b0a72c3ebdf877f0e567271a9a3abc2bc34c94bdc73fcbfff035fad78ed"} 09:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:03 INFO - Contents: 09:53:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eab7988e0d0983c0e3c368558f07bae6437942e47ca2c58737e405cebcf6e54dcfbc11fb19a1cc279619214601f9337531727a08668b441cf7fb9885d8959d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/747750a05c3029f84aba0c5881cf365c69f0cfc39dcbd7e7e7766b902e301602748797fc873c918d40d0ebc2f722fdb130fb62f1e2218819a5898d29faf280b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/915f796df0c49a5f231d2d7d5c293133537c67f1a42dbf724dfc6f9d58a5e4d26f6f0b0a72c3ebdf877f0e567271a9a3abc2bc34c94bdc73fcbfff035fad78ed"} 09:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:03 INFO - Copying logs to upload dir... 09:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.832855 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-17 09:53:03.573591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 09:53:03.576755) ========= 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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eab7988e0d0983c0e3c368558f07bae6437942e47ca2c58737e405cebcf6e54dcfbc11fb19a1cc279619214601f9337531727a08668b441cf7fb9885d8959d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/747750a05c3029f84aba0c5881cf365c69f0cfc39dcbd7e7e7766b902e301602748797fc873c918d40d0ebc2f722fdb130fb62f1e2218819a5898d29faf280b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/915f796df0c49a5f231d2d7d5c293133537c67f1a42dbf724dfc6f9d58a5e4d26f6f0b0a72c3ebdf877f0e567271a9a3abc2bc34c94bdc73fcbfff035fad78ed"} build_url:https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011739 build_url: 'https://queue.taskcluster.net/v1/task/GwtE91rUTQ60JxFqjN7VAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eab7988e0d0983c0e3c368558f07bae6437942e47ca2c58737e405cebcf6e54dcfbc11fb19a1cc279619214601f9337531727a08668b441cf7fb9885d8959d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/747750a05c3029f84aba0c5881cf365c69f0cfc39dcbd7e7e7766b902e301602748797fc873c918d40d0ebc2f722fdb130fb62f1e2218819a5898d29faf280b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/915f796df0c49a5f231d2d7d5c293133537c67f1a42dbf724dfc6f9d58a5e4d26f6f0b0a72c3ebdf877f0e567271a9a3abc2bc34c94bdc73fcbfff035fad78ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 09:53:03.609671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:53:03.610028) ========= 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=5bd038846534b2fdfa68eeae000001e2-1479403940.848432-1440751099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:53:03.695551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 09:53:03.695921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 09:53:03.696281) ========= ========= Total master_lag: 0.19 =========