builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1484901300.13 results: success (0) buildid: 20170119223124 builduid: 25c8bca62c634893bcf928fde825b34c revision: 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.128924) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.129375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.129672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.144085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.144347) ========= 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=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-20 00:35:00-- 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% 114M=0s 2017-01-20 00:35:00 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.266179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.266486) ========= 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=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016763 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.317008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:00.317330) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec --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=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-20 00:35:00,438 truncating revision to first 12 chars 2017-01-20 00:35:00,438 Setting DEBUG logging. 2017-01-20 00:35:00,438 attempt 1/10 2017-01-20 00:35:00,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4a274293090d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 00:35:00,827 unpacking tar archive at: mozilla-aurora-4a274293090d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:01.043855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:01.044175) ========= script_repo_revision: 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:01.044606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:01.044883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 00:35:01.061466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-20 00:35:01.061752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:35:01 INFO - MultiFileLogger online at 20170120 00:35:01 in /builds/slave/test 00:35:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:35:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:35:01 INFO - {'append_to_log': False, 00:35:01 INFO - 'base_work_dir': '/builds/slave/test', 00:35:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:35:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:35:01 INFO - 'branch': 'Mozilla-Aurora', 00:35:01 INFO - 'buildbot_json_path': 'buildprops.json', 00:35:01 INFO - 'config_files': ('talos/linux_config.py',), 00:35:01 INFO - 'default_actions': ('clobber', 00:35:01 INFO - 'read-buildbot-config', 00:35:01 INFO - 'download-and-extract', 00:35:01 INFO - 'populate-webroot', 00:35:01 INFO - 'create-virtualenv', 00:35:01 INFO - 'install', 00:35:01 INFO - 'run-tests'), 00:35:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:35:01 INFO - 'download_minidump_stackwalk': True, 00:35:01 INFO - 'download_symbols': 'ondemand', 00:35:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:35:01 INFO - 'tooltool.py': '/tools/tooltool.py', 00:35:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:35:01 INFO - '/tools/misc-python/virtualenv.py')}, 00:35:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:35:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:35:01 INFO - 'installer_path': 'installer.exe', 00:35:01 INFO - 'log_level': 'info', 00:35:01 INFO - 'log_name': 'talos', 00:35:01 INFO - 'log_to_console': True, 00:35:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:35:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:35:01 INFO - 'opt_config_files': (), 00:35:01 INFO - 'pip_index': False, 00:35:01 INFO - 'sps_profile': False, 00:35:01 INFO - 'sps_profile_interval': 0, 00:35:01 INFO - 'suite': 'dromaeojs', 00:35:01 INFO - 'system_bits': '32', 00:35:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:35:01 INFO - 'title': 'talos-linux64-ix-031', 00:35:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:35:01 INFO - 'use_talos_json': True, 00:35:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:35:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:35:01 INFO - 'work_dir': 'build'} 00:35:01 INFO - [mozharness: 2017-01-20 08:35:01.276137Z] Running clobber step. 00:35:01 INFO - Running pre-action listener: _resource_record_pre_action 00:35:01 INFO - Running main action method: clobber 00:35:01 INFO - rmtree: /builds/slave/test/build 00:35:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:35:01 INFO - Running post-action listener: _resource_record_post_action 00:35:01 INFO - [mozharness: 2017-01-20 08:35:01.735580Z] Finished clobber step (success) 00:35:01 INFO - [mozharness: 2017-01-20 08:35:01.735678Z] Running read-buildbot-config step. 00:35:01 INFO - Running pre-action listener: _resource_record_pre_action 00:35:01 INFO - Running main action method: read_buildbot_config 00:35:01 INFO - Using buildbot properties: 00:35:01 INFO - { 00:35:01 INFO - "project": "", 00:35:01 INFO - "product": "firefox", 00:35:01 INFO - "script_repo_revision": "production", 00:35:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:35:01 INFO - "repository": "", 00:35:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 00:35:01 INFO - "buildid": "20170119223124", 00:35:01 INFO - "pgo_build": "True", 00:35:01 INFO - "basedir": "/builds/slave/test", 00:35:01 INFO - "buildnumber": 1016, 00:35:01 INFO - "slavename": "talos-linux64-ix-031", 00:35:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:35:01 INFO - "platform": "ubuntu64_hw", 00:35:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:35:01 INFO - "branch": "mozilla-aurora", 00:35:01 INFO - "repo_path": "releases/mozilla-aurora", 00:35:01 INFO - "revision": "4a274293090db1dce0d2bbce05ebb6f4cf7f45ec", 00:35:01 INFO - "stage_platform": "linux64-pgo", 00:35:01 INFO - "builduid": "25c8bca62c634893bcf928fde825b34c", 00:35:01 INFO - "slavebuilddir": "test" 00:35:01 INFO - } 00:35:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 00:35:01 INFO - Running post-action listener: _resource_record_post_action 00:35:01 INFO - [mozharness: 2017-01-20 08:35:01.738125Z] Finished read-buildbot-config step (success) 00:35:01 INFO - [mozharness: 2017-01-20 08:35:01.738213Z] Running download-and-extract step. 00:35:01 INFO - Running pre-action listener: _resource_record_pre_action 00:35:01 INFO - Running main action method: download_and_extract 00:35:01 INFO - mkdir: /builds/slave/test/build/tests 00:35:01 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')]} 00:35:01 INFO - trying https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:35:01 INFO - Downloading https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:35:02 INFO - Downloaded 1361 bytes. 00:35:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:35:02 INFO - Using the following test package requirements: 00:35:02 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:35:02 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:35:02 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:35:02 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'jsshell-linux-x86_64.zip'], 00:35:02 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:35:02 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:35:02 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:35:02 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:35:02 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:35:02 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:35:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:35:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:35:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:35:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:35:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:35:02 INFO - Http code: 200 00:35:02 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 00:35:02 INFO - x-amz-cf-id: rZpcvx35KnVSnSRFjFSFhGMC1wHAKP-FmtXvBAsipexPxwULc8k_pA== 00:35:02 INFO - x-amz-version-id: 1See_5I_920mkfVxA1G5bzlViR50bHVN 00:35:03 INFO - Expected file size: 21949064 00:35:03 INFO - Obtained file size: 21949064 00:35:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:35:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:35:07 INFO - Http code: 200 00:35:07 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 00:35:07 INFO - x-amz-cf-id: xmWaefvkOKsbjiGHuouQPV_6sciDKtVHhBRw-YMcIXRLmYAQbyzkhw== 00:35:07 INFO - x-amz-version-id: 1See_5I_920mkfVxA1G5bzlViR50bHVN 00:35:07 INFO - Expected file size: 21949064 00:35:07 INFO - Obtained file size: 21949064 00:35:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 00:35:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:35:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 00:35:12 INFO - Http code: 200 00:35:12 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 00:35:12 INFO - x-amz-cf-id: Ejd_iCmz-PvJq8WIFxsFUufR2ELobseqnREEQjbB5IY9E8GwCgPpDQ== 00:35:12 INFO - x-amz-version-id: A2vF5zhihJXgyMGEBso_avtj5CZTdQOo 00:35:13 INFO - Expected file size: 14409038 00:35:13 INFO - Obtained file size: 14409038 00:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:13 INFO - trying https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:35:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:35:14 INFO - Downloaded 64215143 bytes. 00:35:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:35:14 INFO - mkdir: /builds/slave/test/properties 00:35:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:35:14 INFO - Writing to file /builds/slave/test/properties/build_url 00:35:14 INFO - Contents: 00:35:14 INFO - build_url:https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:35:15 INFO - Running post-action listener: _resource_record_post_action 00:35:15 INFO - Running post-action listener: set_extra_try_arguments 00:35:15 INFO - [mozharness: 2017-01-20 08:35:15.211089Z] Finished download-and-extract step (success) 00:35:15 INFO - [mozharness: 2017-01-20 08:35:15.211386Z] Running populate-webroot step. 00:35:15 INFO - Running pre-action listener: _resource_record_pre_action 00:35:15 INFO - Running main action method: populate_webroot 00:35:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:35:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:35:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:35:15 INFO - '--tppagecycles', 00:35:15 INFO - '7'], 00:35:15 INFO - 'tests': ['tsvgm']}}, 00:35:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:35:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:35:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:35:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:35:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:35:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['damp', 'tps']}, 00:35:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'tests': ['damp', 'tps']}, 00:35:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['dromaeo_dom']}, 00:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:35:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['basic_compositor_video']}, 00:35:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:35:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['a11yr', 00:35:15 INFO - 'ts_paint', 00:35:15 INFO - 'tpaint', 00:35:15 INFO - 'sessionrestore', 00:35:15 INFO - 'sessionrestore_no_auto_restore', 00:35:15 INFO - 'tabpaint']}, 00:35:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['tsvgx', 00:35:15 INFO - 'tsvgr_opacity', 00:35:15 INFO - 'tart', 00:35:15 INFO - 'tscrollx', 00:35:15 INFO - 'cart']}, 00:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:35:15 INFO - 'tsvgr_opacity', 00:35:15 INFO - 'tart', 00:35:15 INFO - 'tscrollx', 00:35:15 INFO - 'cart']}, 00:35:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'talos_options': ['--disable-e10s'], 00:35:15 INFO - 'tests': ['tp5o']}, 00:35:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'tests': ['tp5o']}, 00:35:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'talos_options': ['--disable-e10s', 00:35:15 INFO - '--xperf_path', 00:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:35:15 INFO - 'tests': ['tp5n']}, 00:35:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:35:15 INFO - 'talos_options': ['--xperf_path', 00:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:35:15 INFO - 'tests': ['tp5n']}}, 00:35:15 INFO - 'talos.zip': {'path': '', 00:35:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:35:15 INFO - Running post-action listener: _resource_record_post_action 00:35:15 INFO - [mozharness: 2017-01-20 08:35:15.234730Z] Finished populate-webroot step (success) 00:35:15 INFO - [mozharness: 2017-01-20 08:35:15.234821Z] Running create-virtualenv step. 00:35:15 INFO - Running pre-action listener: _resource_record_pre_action 00:35:15 INFO - Running main action method: create_virtualenv 00:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 00:35:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:35:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:35:15 INFO - Using real prefix '/usr' 00:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:35:15 INFO - Installing distribute.............................................................................................................................................................................................done. 00:35:17 INFO - Installing pip.................done. 00:35:17 INFO - Return code: 0 00:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:35:18 INFO - Reading from file tmpfile_stdout 00:35:18 INFO - Output received: 00:35:18 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) 00:35:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:35:18 INFO - Using env: {'DISPLAY': ':0', 00:35:18 INFO - 'HOME': '/home/cltbld', 00:35:18 INFO - 'LANG': 'en_US.UTF-8', 00:35:18 INFO - 'LANGUAGE': 'en_US:en', 00:35:18 INFO - 'LOGNAME': 'cltbld', 00:35:18 INFO - 'MAIL': '/var/mail/cltbld', 00:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:18 INFO - 'MOZ_NO_REMOTE': '1', 00:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:18 INFO - 'NO_EM_RESTART': '1', 00:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:18 INFO - 'PWD': '/builds/slave/test', 00:35:18 INFO - 'SHELL': '/bin/bash', 00:35:18 INFO - 'SHLVL': '1', 00:35:18 INFO - 'TERM': 'linux', 00:35:18 INFO - 'TMOUT': '86400', 00:35:18 INFO - 'USER': 'cltbld', 00:35:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:18 INFO - '_': '/tools/buildbot/bin/python'} 00:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:35:18 INFO - Cleaning up... 00:35:18 INFO - Return code: 0 00:35:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:35:18 INFO - Using env: {'DISPLAY': ':0', 00:35:18 INFO - 'HOME': '/home/cltbld', 00:35:18 INFO - 'LANG': 'en_US.UTF-8', 00:35:18 INFO - 'LANGUAGE': 'en_US:en', 00:35:18 INFO - 'LOGNAME': 'cltbld', 00:35:18 INFO - 'MAIL': '/var/mail/cltbld', 00:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:18 INFO - 'MOZ_NO_REMOTE': '1', 00:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:18 INFO - 'NO_EM_RESTART': '1', 00:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:18 INFO - 'PWD': '/builds/slave/test', 00:35:18 INFO - 'SHELL': '/bin/bash', 00:35:18 INFO - 'SHLVL': '1', 00:35:18 INFO - 'TERM': 'linux', 00:35:18 INFO - 'TMOUT': '86400', 00:35:18 INFO - 'USER': 'cltbld', 00:35:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:18 INFO - '_': '/tools/buildbot/bin/python'} 00:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:18 INFO - Downloading/unpacking psutil>=3.1.1 00:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:35:20 INFO - Installing collected packages: psutil 00:35:20 INFO - Running setup.py install for psutil 00:35:20 INFO - building 'psutil._psutil_linux' extension 00:35:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:35:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:35:20 INFO - building 'psutil._psutil_posix' extension 00:35:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:35:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:35:21 INFO - Successfully installed psutil 00:35:21 INFO - Cleaning up... 00:35:21 INFO - Return code: 0 00:35:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:35:21 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')]} 00:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:21 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')]} 00:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:21 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 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:21 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 00:35:21 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 00:35:21 INFO - Using env: {'DISPLAY': ':0', 00:35:21 INFO - 'HOME': '/home/cltbld', 00:35:21 INFO - 'LANG': 'en_US.UTF-8', 00:35:21 INFO - 'LANGUAGE': 'en_US:en', 00:35:21 INFO - 'LOGNAME': 'cltbld', 00:35:21 INFO - 'MAIL': '/var/mail/cltbld', 00:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:21 INFO - 'MOZ_NO_REMOTE': '1', 00:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:21 INFO - 'NO_EM_RESTART': '1', 00:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:21 INFO - 'PWD': '/builds/slave/test', 00:35:21 INFO - 'SHELL': '/bin/bash', 00:35:21 INFO - 'SHLVL': '1', 00:35:21 INFO - 'TERM': 'linux', 00:35:21 INFO - 'TMOUT': '86400', 00:35:21 INFO - 'USER': 'cltbld', 00:35:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:21 INFO - '_': '/tools/buildbot/bin/python'} 00:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:35:23 INFO - Installing collected packages: mozsystemmonitor 00:35:23 INFO - Running setup.py install for mozsystemmonitor 00:35:23 INFO - Successfully installed mozsystemmonitor 00:35:23 INFO - Cleaning up... 00:35:23 INFO - Return code: 0 00:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:35: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')]} 00:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35: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')]} 00:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:35:23 INFO - Using env: {'DISPLAY': ':0', 00:35:23 INFO - 'HOME': '/home/cltbld', 00:35:23 INFO - 'LANG': 'en_US.UTF-8', 00:35:23 INFO - 'LANGUAGE': 'en_US:en', 00:35:23 INFO - 'LOGNAME': 'cltbld', 00:35:23 INFO - 'MAIL': '/var/mail/cltbld', 00:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:23 INFO - 'MOZ_NO_REMOTE': '1', 00:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:23 INFO - 'NO_EM_RESTART': '1', 00:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:23 INFO - 'PWD': '/builds/slave/test', 00:35:23 INFO - 'SHELL': '/bin/bash', 00:35:23 INFO - 'SHLVL': '1', 00:35:23 INFO - 'TERM': 'linux', 00:35:23 INFO - 'TMOUT': '86400', 00:35:23 INFO - 'USER': 'cltbld', 00:35:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:23 INFO - '_': '/tools/buildbot/bin/python'} 00:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 00:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:35:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:25 INFO - Downloading functools32-3.2.3-2.tar.gz 00:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:35:26 INFO - warning: no files found matching '*.txt' 00:35:26 INFO - no previously-included directories found matching 'build' 00:35:26 INFO - no previously-included directories found matching 'dist' 00:35:26 INFO - no previously-included directories found matching '.git*' 00:35:26 INFO - Installing collected packages: jsonschema, functools32 00:35:26 INFO - Running setup.py install for functools32 00:35:26 INFO - warning: no files found matching '*.txt' 00:35:26 INFO - no previously-included directories found matching 'build' 00:35:26 INFO - no previously-included directories found matching 'dist' 00:35:26 INFO - no previously-included directories found matching '.git*' 00:35:26 INFO - Successfully installed jsonschema functools32 00:35:26 INFO - Cleaning up... 00:35:26 INFO - Return code: 0 00:35:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:35:26 INFO - Using env: {'DISPLAY': ':0', 00:35:26 INFO - 'HOME': '/home/cltbld', 00:35:26 INFO - 'LANG': 'en_US.UTF-8', 00:35:26 INFO - 'LANGUAGE': 'en_US:en', 00:35:26 INFO - 'LOGNAME': 'cltbld', 00:35:26 INFO - 'MAIL': '/var/mail/cltbld', 00:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:26 INFO - 'MOZ_NO_REMOTE': '1', 00:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:26 INFO - 'NO_EM_RESTART': '1', 00:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:26 INFO - 'PWD': '/builds/slave/test', 00:35:26 INFO - 'SHELL': '/bin/bash', 00:35:26 INFO - 'SHLVL': '1', 00:35:26 INFO - 'TERM': 'linux', 00:35:26 INFO - 'TMOUT': '86400', 00:35:26 INFO - 'USER': 'cltbld', 00:35:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:26 INFO - '_': '/tools/buildbot/bin/python'} 00:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:35:26 INFO - Cleaning up... 00:35:26 INFO - Return code: 0 00:35:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:35:26 INFO - Using env: {'DISPLAY': ':0', 00:35:26 INFO - 'HOME': '/home/cltbld', 00:35:26 INFO - 'LANG': 'en_US.UTF-8', 00:35:26 INFO - 'LANGUAGE': 'en_US:en', 00:35:26 INFO - 'LOGNAME': 'cltbld', 00:35:26 INFO - 'MAIL': '/var/mail/cltbld', 00:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:26 INFO - 'MOZ_NO_REMOTE': '1', 00:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:26 INFO - 'NO_EM_RESTART': '1', 00:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:26 INFO - 'PWD': '/builds/slave/test', 00:35:26 INFO - 'SHELL': '/bin/bash', 00:35:26 INFO - 'SHLVL': '1', 00:35:26 INFO - 'TERM': 'linux', 00:35:26 INFO - 'TMOUT': '86400', 00:35:26 INFO - 'USER': 'cltbld', 00:35:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:26 INFO - '_': '/tools/buildbot/bin/python'} 00:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:26 INFO - Downloading/unpacking blobuploader==1.2.4 00:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:28 INFO - Downloading blobuploader-1.2.4.tar.gz 00:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:35:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:35:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:35:29 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 00:35:29 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 00:35:29 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 00:35:29 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 00:35:29 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 00:35:29 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 00:35:29 INFO - Downloading docopt-0.6.1.tar.gz 00:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:35:29 INFO - Installing collected packages: blobuploader, requests, docopt 00:35:29 INFO - Running setup.py install for blobuploader 00:35:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:35:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:35:29 INFO - Running setup.py install for requests 00:35:29 INFO - Running setup.py install for docopt 00:35:30 INFO - Successfully installed blobuploader requests docopt 00:35:30 INFO - Cleaning up... 00:35:30 INFO - Return code: 0 00:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35:30 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')]} 00:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:30 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')]} 00:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:30 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 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:30 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 00:35:30 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 00:35:30 INFO - Using env: {'DISPLAY': ':0', 00:35:30 INFO - 'HOME': '/home/cltbld', 00:35:30 INFO - 'LANG': 'en_US.UTF-8', 00:35:30 INFO - 'LANGUAGE': 'en_US:en', 00:35:30 INFO - 'LOGNAME': 'cltbld', 00:35:30 INFO - 'MAIL': '/var/mail/cltbld', 00:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:30 INFO - 'MOZ_NO_REMOTE': '1', 00:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:30 INFO - 'NO_EM_RESTART': '1', 00:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:30 INFO - 'PWD': '/builds/slave/test', 00:35:30 INFO - 'SHELL': '/bin/bash', 00:35:30 INFO - 'SHLVL': '1', 00:35:30 INFO - 'TERM': 'linux', 00:35:30 INFO - 'TMOUT': '86400', 00:35:30 INFO - 'USER': 'cltbld', 00:35:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:30 INFO - '_': '/tools/buildbot/bin/python'} 00:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:35:30 INFO - Running setup.py (path:/tmp/pip-XIOk6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:35:30 INFO - Running setup.py (path:/tmp/pip-SBLboa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:35:30 INFO - Running setup.py (path:/tmp/pip-MMTAB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:35:30 INFO - Running setup.py (path:/tmp/pip-fjduMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:35:30 INFO - Running setup.py (path:/tmp/pip-YPjoRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:35:30 INFO - Running setup.py (path:/tmp/pip-DBPphP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:35:30 INFO - Running setup.py (path:/tmp/pip-MggNR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:35:30 INFO - Running setup.py (path:/tmp/pip-RMZit0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:35:30 INFO - Running setup.py (path:/tmp/pip-y4Rwio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:35:30 INFO - Running setup.py (path:/tmp/pip-MtlSjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:35:31 INFO - Running setup.py (path:/tmp/pip-exr0Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:35:31 INFO - Running setup.py (path:/tmp/pip-MZezQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:35:31 INFO - Running setup.py (path:/tmp/pip-sQMrbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:35:31 INFO - Running setup.py (path:/tmp/pip-w0X7l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:31 INFO - Running setup.py (path:/tmp/pip-i5DzXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:35:31 INFO - Running setup.py (path:/tmp/pip-pFOuSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:35:31 INFO - Running setup.py (path:/tmp/pip-hcrwAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:35:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:35:31 INFO - Running setup.py install for manifestparser 00:35:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:35:31 INFO - Running setup.py install for mozcrash 00:35:31 INFO - Running setup.py install for mozdebug 00:35:31 INFO - Running setup.py install for mozdevice 00:35:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:35:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:35:31 INFO - Running setup.py install for mozfile 00:35:32 INFO - Running setup.py install for mozhttpd 00:35:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for mozinfo 00:35:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for mozInstall 00:35:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for mozleak 00:35:32 INFO - Running setup.py install for mozlog 00:35:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for moznetwork 00:35:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for mozprocess 00:35:32 INFO - Running setup.py install for mozprofile 00:35:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:35:32 INFO - Running setup.py install for mozrunner 00:35:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:35:33 INFO - Running setup.py install for mozscreenshot 00:35:33 INFO - Running setup.py install for moztest 00:35:33 INFO - Running setup.py install for mozversion 00:35:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:35:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:35:33 INFO - Cleaning up... 00:35:33 INFO - Return code: 0 00:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35:33 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')]} 00:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:33 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')]} 00:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:33 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 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:33 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 00:35:33 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 00:35:33 INFO - Using env: {'DISPLAY': ':0', 00:35:33 INFO - 'HOME': '/home/cltbld', 00:35:33 INFO - 'LANG': 'en_US.UTF-8', 00:35:33 INFO - 'LANGUAGE': 'en_US:en', 00:35:33 INFO - 'LOGNAME': 'cltbld', 00:35:33 INFO - 'MAIL': '/var/mail/cltbld', 00:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:33 INFO - 'MOZ_NO_REMOTE': '1', 00:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:33 INFO - 'NO_EM_RESTART': '1', 00:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:33 INFO - 'PWD': '/builds/slave/test', 00:35:33 INFO - 'SHELL': '/bin/bash', 00:35:33 INFO - 'SHLVL': '1', 00:35:33 INFO - 'TERM': 'linux', 00:35:33 INFO - 'TMOUT': '86400', 00:35:33 INFO - 'USER': 'cltbld', 00:35:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:33 INFO - '_': '/tools/buildbot/bin/python'} 00:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:35:33 INFO - Running setup.py (path:/tmp/pip-WPWtOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:35:33 INFO - Running setup.py (path:/tmp/pip-2GS3ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:35:33 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)) 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:35:33 INFO - Running setup.py (path:/tmp/pip-XpgD3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:35:33 INFO - Running setup.py (path:/tmp/pip-WjY4tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:35:33 INFO - Running setup.py (path:/tmp/pip-6y5wL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:35:33 INFO - Running setup.py (path:/tmp/pip-LP4O5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:35:34 INFO - Running setup.py (path:/tmp/pip-RvvSTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:35:34 INFO - Running setup.py (path:/tmp/pip-tvP1Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:35:34 INFO - Running setup.py (path:/tmp/pip-LMGsWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:35:34 INFO - Running setup.py (path:/tmp/pip-ZNm1l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:35:34 INFO - Running setup.py (path:/tmp/pip-5qKLvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:35:34 INFO - Running setup.py (path:/tmp/pip-t5smOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:35:34 INFO - Running setup.py (path:/tmp/pip-YOYxg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:35:34 INFO - Running setup.py (path:/tmp/pip-b7zxCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:35:34 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:34 INFO - Running setup.py (path:/tmp/pip-xAQ16m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:35:34 INFO - Running setup.py (path:/tmp/pip-Z1PANe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 00:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:35:34 INFO - Running setup.py (path:/tmp/pip-70QKkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:35:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:35:36 INFO - Downloading blessings-1.6.tar.gz 00:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:35:36 INFO - Installing collected packages: blessings 00:35:36 INFO - Running setup.py install for blessings 00:35:37 INFO - Successfully installed blessings 00:35:37 INFO - Cleaning up... 00:35:37 INFO - Return code: 0 00:35:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:35:37 INFO - Reading from file tmpfile_stdout 00:35:37 INFO - Current package versions: 00:35:37 INFO - argparse == 1.2.1 00:35:37 INFO - blessings == 1.6 00:35:37 INFO - blobuploader == 1.2.4 00:35:37 INFO - docopt == 0.6.1 00:35:37 INFO - functools32 == 3.2.3-2 00:35:37 INFO - jsonschema == 2.5.1 00:35:37 INFO - manifestparser == 1.1 00:35:37 INFO - mozInstall == 1.12 00:35:37 INFO - mozcrash == 1.0 00:35:37 INFO - mozdebug == 0.1 00:35:37 INFO - mozdevice == 0.48 00:35:37 INFO - mozfile == 1.2 00:35:37 INFO - mozhttpd == 0.7 00:35:37 INFO - mozinfo == 0.9 00:35:37 INFO - mozleak == 0.1 00:35:37 INFO - mozlog == 3.4 00:35:37 INFO - moznetwork == 0.27 00:35:37 INFO - mozprocess == 0.23 00:35:37 INFO - mozprofile == 0.28 00:35:37 INFO - mozrunner == 6.13 00:35:37 INFO - mozscreenshot == 0.1 00:35:37 INFO - mozsystemmonitor == 0.3 00:35:37 INFO - moztest == 0.8 00:35:37 INFO - mozversion == 1.4 00:35:37 INFO - psutil == 3.1.1 00:35:37 INFO - requests == 1.2.3 00:35:37 INFO - wsgiref == 0.1.2 00:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:37 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 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:37 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 00:35:37 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 00:35:37 INFO - Using env: {'DISPLAY': ':0', 00:35:37 INFO - 'HOME': '/home/cltbld', 00:35:37 INFO - 'LANG': 'en_US.UTF-8', 00:35:37 INFO - 'LANGUAGE': 'en_US:en', 00:35:37 INFO - 'LOGNAME': 'cltbld', 00:35:37 INFO - 'MAIL': '/var/mail/cltbld', 00:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:37 INFO - 'MOZ_NO_REMOTE': '1', 00:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:37 INFO - 'NO_EM_RESTART': '1', 00:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:37 INFO - 'PWD': '/builds/slave/test', 00:35:37 INFO - 'SHELL': '/bin/bash', 00:35:37 INFO - 'SHLVL': '1', 00:35:37 INFO - 'TERM': 'linux', 00:35:37 INFO - 'TMOUT': '86400', 00:35:37 INFO - 'USER': 'cltbld', 00:35:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:37 INFO - '_': '/tools/buildbot/bin/python'} 00:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 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)) 00:35:37 INFO - Cleaning up... 00:35:37 INFO - Return code: 0 00:35:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:35:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb81ef2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', '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 00:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:35:37 INFO - Using env: {'DISPLAY': ':0', 00:35:37 INFO - 'HOME': '/home/cltbld', 00:35:37 INFO - 'LANG': 'en_US.UTF-8', 00:35:37 INFO - 'LANGUAGE': 'en_US:en', 00:35:37 INFO - 'LOGNAME': 'cltbld', 00:35:37 INFO - 'MAIL': '/var/mail/cltbld', 00:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:37 INFO - 'MOZ_NO_REMOTE': '1', 00:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:37 INFO - 'NO_EM_RESTART': '1', 00:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:37 INFO - 'PWD': '/builds/slave/test', 00:35:37 INFO - 'SHELL': '/bin/bash', 00:35:37 INFO - 'SHLVL': '1', 00:35:37 INFO - 'TERM': 'linux', 00:35:37 INFO - 'TMOUT': '86400', 00:35:37 INFO - 'USER': 'cltbld', 00:35:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:37 INFO - '_': '/tools/buildbot/bin/python'} 00:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:35:37 INFO - Cleaning up... 00:35:37 INFO - Return code: 0 00:35:37 INFO - Running post-action listener: _resource_record_post_action 00:35:37 INFO - Running post-action listener: _start_resource_monitoring 00:35:37 INFO - Starting resource monitoring. 00:35:37 INFO - [mozharness: 2017-01-20 08:35:37.802263Z] Finished create-virtualenv step (success) 00:35:37 INFO - [mozharness: 2017-01-20 08:35:37.802765Z] Running install step. 00:35:37 INFO - Running pre-action listener: _resource_record_pre_action 00:35:37 INFO - Running main action method: install 00:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:35:38 INFO - Reading from file tmpfile_stdout 00:35:38 INFO - Detecting whether we're running mozinstall >=1.0... 00:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:35:38 INFO - Reading from file tmpfile_stdout 00:35:38 INFO - Output received: 00:35:38 INFO - Usage: mozinstall [options] installer 00:35:38 INFO - Options: 00:35:38 INFO - -h, --help show this help message and exit 00:35:38 INFO - -d DEST, --destination=DEST 00:35:38 INFO - Directory to install application into. [default: 00:35:38 INFO - "/builds/slave/test"] 00:35:38 INFO - --app=APP Application being installed. [default: firefox] 00:35:38 INFO - mkdir: /builds/slave/test/build/application 00:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:35:54 INFO - Reading from file tmpfile_stdout 00:35:54 INFO - Output received: 00:35:54 INFO - /builds/slave/test/build/application/firefox/firefox 00:35:54 INFO - Running post-action listener: _resource_record_post_action 00:35:54 INFO - [mozharness: 2017-01-20 08:35:54.063079Z] Finished install step (success) 00:35:54 INFO - [mozharness: 2017-01-20 08:35:54.063322Z] Running run-tests step. 00:35:54 INFO - Running pre-action listener: _resource_record_pre_action 00:35:54 INFO - Running main action method: run_tests 00:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:35:54 INFO - Python 2.7.3 00:35:54 INFO - Return code: 0 00:35:54 INFO - grabbing minidump binary from tooltool 00:35: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')]} 00:35:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1737f60>, '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 0x1738d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17391d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:35:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:35:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:35:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:35:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:35:54 INFO - Return code: 0 00:35:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:35:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:35:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:35:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:35:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 00:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 00:35:54 INFO - Using env: {'DISPLAY': ':0', 00:35:54 INFO - 'HOME': '/home/cltbld', 00:35:54 INFO - 'LANG': 'en_US.UTF-8', 00:35:54 INFO - 'LANGUAGE': 'en_US:en', 00:35:54 INFO - 'LOGNAME': 'cltbld', 00:35:54 INFO - 'MAIL': '/var/mail/cltbld', 00:35:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:35:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:35:54 INFO - 'MOZ_NO_REMOTE': '1', 00:35:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:35:54 INFO - 'NO_EM_RESTART': '1', 00:35:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:35:54 INFO - 'PWD': '/builds/slave/test', 00:35:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:35:54 INFO - 'SHELL': '/bin/bash', 00:35:54 INFO - 'SHLVL': '1', 00:35:54 INFO - 'TERM': 'linux', 00:35:54 INFO - 'TMOUT': '86400', 00:35:54 INFO - 'USER': 'cltbld', 00:35:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166', 00:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:35:54 INFO - '_': '/tools/buildbot/bin/python'} 00:35:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 00:35:54 INFO - mozversion application_buildid: 20170119223124 00:35:54 INFO - mozversion application_changeset: 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec 00:35:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:35:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:35:54 INFO - mozversion application_name: Firefox 00:35:54 INFO - mozversion application_remotingname: firefox-dev 00:35:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:35:54 INFO - mozversion application_vendor: Mozilla 00:35:54 INFO - mozversion application_version: 52.0a2 00:35:54 INFO - mozversion platform_buildid: 20170119223124 00:35:54 INFO - mozversion platform_changeset: 4a274293090db1dce0d2bbce05ebb6f4cf7f45ec 00:35:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:35:54 INFO - mozversion platform_version: 52.0a2 00:35:54 INFO - using testdate: 1484901354 00:35:54 INFO - actual date: 1484901354 00:35:54 INFO - starting webserver on 'localhost:48404' 00:35:54 INFO - SUITE-START | Running 2 tests 00:35:54 INFO - TEST-START | dromaeo_css 00:35:54 INFO - operating with platform_type : linux_ 00:35:54 INFO - Initialising browser for dromaeo_css test... 00:35:54 INFO - TEST-INFO | started process 27539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2dpiw/profile http://localhost:48404/getInfo.html) 00:35:58 INFO - PROCESS | 27539 | __metrics Screen width/height:1600/1200 00:35:58 INFO - PROCESS | 27539 | colorDepth:24 00:35:58 INFO - PROCESS | 27539 | Browser inner width/height: 1024/697 00:35:58 INFO - PROCESS | 27539 | __metrics 00:35:58 INFO - PROCESS | 27539 | 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" 00:35:58 INFO - PROCESS | 27539 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:35:59 INFO - PROCESS | 27539 | console.error: PushService: 00:35:59 INFO - PROCESS | 27539 | stateChangeProcessEnqueue: Error transitioning state 00:35:59 INFO - PROCESS | 27539 | UnknownError 00:35:59 INFO - TEST-INFO | 27539: exit 0 00:35:59 INFO - Browser initialized. 00:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 00:35:59 INFO - TEST-INFO | started process 27631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2dpiw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:36:11 INFO - PROCESS | 27631 | RSS: Main: 147173376 00:36:11 INFO - PROCESS | 27631 | 00:39:12 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48404/tests/dromaeo/cssquery-ext.html) 00:39:14 INFO - PROCESS | 27631 | RSS: Main: 307617792 00:39:14 INFO - PROCESS | 27631 | 00:42:17 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-ext.html (next: http://localhost:48404/tests/dromaeo/cssquery-jquery.html) 00:42:17 INFO - PROCESS | 27631 | RSS: Main: 217559040 00:42:17 INFO - PROCESS | 27631 | 00:45:19 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48404/tests/dromaeo/cssquery-mootools.html) 00:45:20 INFO - PROCESS | 27631 | RSS: Main: 174940160 00:45:20 INFO - PROCESS | 27631 | 00:48:22 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48404/tests/dromaeo/cssquery-prototype.html) 00:48:22 INFO - PROCESS | 27631 | RSS: Main: 175906816 00:48:22 INFO - PROCESS | 27631 | 00:51:25 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48404/tests/dromaeo/cssquery-yui.html) 00:51:26 INFO - PROCESS | 27631 | RSS: Main: 174342144 00:51:26 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | Cycle 1(1): loaded http://localhost:48404/tests/dromaeo/cssquery-yui.html (next: http://localhost:48404/tests/dromaeo/cssquery-dojo.html) 00:54:28 INFO - PROCESS | 27631 | RSS: Main: 268840960 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | __start_tp_report 00:54:28 INFO - PROCESS | 27631 | _x_x_mozilla_page_load 00:54:28 INFO - PROCESS | 27631 | _x_x_mozilla_page_load_details 00:54:28 INFO - PROCESS | 27631 | |i|pagename|runs| 00:54:28 INFO - PROCESS | 27631 | |0;dojo.html;3175.7452208931672;3188.171075520365;3199.712025917667;3209.4864821628544;3235.2558911450374;5488.917666235005;5580.665160090387;5593.244911936888;5649.124385720214;5659.915101273474;5689.800856970007;5713.914291285623;5727.398623144572;5733.226014488043;5741.253637027181;5162.406323272815;5184.948150518503;5210.16637338026;5213.3743950725775;5258;4959.851204463872;5249.790008399659;5254.527092561688;5265.9473405266035;5270.736463176845;4941.382327209099;5085.1863701807715;5121.4110377306715;5127.307813445174;5141.948580514184;5156.407013193474;5181.455947125554;5193.480651934814;5255.973720131413;5266.078436273637;5098.566621837112;5134.8202812901745;5216;5219.5041471060185;5247.16045432729;5247.790088396459;5281.8151364702435;5543.057680194376;5564.721763911829;5617.606767526234;6002.009668404708;6021.2473440819895;6034.879302413971;6082.665453400061;6102.60333078353;6147.077938309245;6156.6613836238985;6160.969195154041;6166.84582885427;6167.444929956326;5429.104197807396;5472.1244600864065;5474.37044739856;5536.889262214733;5610.85972850682;6052.152698622196;6067.393260673897;6067.453929146398;6081.483073938764;6084.421979911901;5845.298564172326;5848.64908105515;5851.882962340815;5857.179994800731;5860.765569377262;5741.770329186869;5795.88408231833;6036.577439579188;6082.148499210114;6087.878242435127;6109.777134817779;6129.281740388711;6129.667972160533;6131.866048757567;6132.3652053194055;6091.400843210607;6132.306126318478;6136.978641397139;6146.907796383058;6162.815115546541;4504.61710754583;4565.863024109282;4661.720296782204;4680.017196388796;4784.736839473862;4144;4167.437395951569;4190.643795277436;4195.056112374752;4202.159568086395;5692.288463942007;5695.40198279183;5698.8290351289525;5700.629459085146;5704.971475142598;5776.566757493205;5836.270466191726;5995.550333724988;6107.267127944675;6113.5414843886;5614.354349249807;5684.346300175533;5687.7156142192725;5712.485876271156;5717.399673034354;5204.8959020819375;5207.973960130251;5209.505097015777;5212.061828870764;5212.061828870839;5947.524198064231;6000.729967151401;6192.504599632109;6233.470155036873;6248.375162483715;5956.553258505716;5961.195238642901;6004.369541198286;6060.787872424444;6092.75628974836;6149.08007849457;6165.784197553064;6181.690915454299;6182.227221597301;6183.876322473436;5735.8566035849435;5884.676342801187;5884.882302354014;5921.111833225051;5946.881062378641;5849.151872978309;6039.4262545058145;6039.879202415839;6111.786087486917;6128.167033931239;5977.5217982560425;6024.156618073385;6031.366706495754;6037.18498002764;6037.879242415215;5966.731497082555;5977.282726072899;5977.491913187428;5978.940210597838;5999.130126131599;5627.718614069198;5693.089105743061;5908.084246941731;5928.407159284209;5956.702164891652;6038.064100064497;6039.698015099139;6052.425019623129;6081.513478921587;6086.147939288415;5601.103823388238;5655.688937108334;5902.4097590240635;5912.46787789101;5924.940750592611 00:54:28 INFO - PROCESS | 27631 | |1;ext.html;550.9338879334481;610.4079043327972;638.3584497579932;654.2443477783162;655.7278729327329;32483.51274730878;35555.82222088889;35573.46639800405;42567.57432425683;43365.34951975715;44122;44499;44531.55468445315;44543;44566.55433445665;8855.955720221405;8935.64257429702;9000.729978100635;9002;9005.77485562863;8442.662293508252;8668.913310866905;8828.117188281185;10564;10823.621173258938;10903.182261330392;10933.56265749369;10953.83569246462;10958.123350131971;10967.232293739442;10708.357498550073;10746.838797418044;10802.081823045051;10816;10817.513211905483;10654.573817047309;10692.572297108107;10712.78574428515;10714.678559643224;10720.892791072067;42262.36606450906;42567.787161064;42639.57360426387;42733;42775.35836962448;3720.311742327678;3822.2355528894054;3826.617338266179;3881.2819628368843;4175.498940127204;31135.37729245425;32843.83578082094;33484.6651533484;33731.15672108193;34277.6572234277;4292.935605965913;4294.506131794852;4323.351497275403;4500.639948804121;4542.6138778203895;337763;339060;342926;342950;346690;39001;39955.200895981914;66141;66899;66977.98599063054;41832.37251441231;41953.79023104926;41970.160596788504;41977;42015.159696805895;15174;15277.236138193046;15318.310676019606;15331.080135191924;15386.07683538969;10692.358458492516;12037.157398981988;12039.819402708967;12052.276863388224;12060.638180854588;9101.863472047924;9386.765330866647;9748.658796942073;9759.316847820584;9840.409575425498;3760.304343696425;3760.8683696070507;3829.8468061277235;3864.478295430137;3880.7387599030426;1061.7153244573997;1077.1329080090602;1082.6210826210763;1156.5431654496426;1167.8832116788253;32597.348053038808;32928.67071329256;32957;33154;33899.491507627405;1025.380407162717;1108.2076315434504;1131.134681968295;1197.467127128437;1220.7619514194646;14597.92701036488;17014.829851701572;17375.913120434318;17399.82600173982;17493.650126997643;503291;504772;507541;508276;508654;58190.926635135984;58523;58591.414085858596;58609.12086318708;58693.41306586879;1307.1960744142475;1341.322632070798;1380.5582213691723;1413.3216056293038;1428.243031193469;30629;32398.35203295968;33330.33339333248;33431.49852752162;33550.83224583862;49277.50722492729;49614;49854;49870;49926.251106234165;367876;368964;371676;372458;372686;29555;30286.091417257518;30614.693853061184;31951.840240798647;31967.200819979687;47658.28512572245;48282.275765864244;48331;48492;52466.73766631143;41000;41177;41275.38086928758;41433;43041.569584303754;40391.596084038785;40740;40990.385144222266;41174.58825411707;42410.787946060074;40005.79997099996;40170.79914600408;40304.79847600743;40565.39151912665;41451.7927410361;35496.290074198885;36857.63142368649;37251;37306.81346593249;37852;27173.184804455897;28067.562096044156;28139.93003498251;28409.28976775597;28421.573676395285 00:54:28 INFO - PROCESS | 27631 | |2;jquery.html;400.35342921182263;419.19514532098367;422.1535820679536;426.5776880887922;430.1504528556101;17331.39340123096;19424.417267481964;19853.801461985375;19952.900235498837;20005.099770510307;19389;19776.70334944977;19827;19977.900110499464;20105.29631462899;4802.447718512363;5631.60578759487;5652.265205523277;5796.50729687977;5847.912281315784;5730.255066841326;5816.854578635525;5822.941770582303;5823.563232757539;5824.592278540504;5681.886362272752;5732.283464566929;5767.394423585526;5795.043817770063;5826.388229235933;5562.16567514872;5763.5101016413655;5797.884042319172;5798.884022319551;5827.621204621707;5207.479252074762;5239.79040838366;5245.291885595472;5246.7901283948595;5248.134057880445;22230.88884555567;22379.55240895173;22559.887200564055;22809.201677941357;23346.066157353856;2412.2763171048614;2476.839005464639;2520.357308886222;2611.738826117392;3135.2318681922848;15399.923000384926;15739;15780.842191578053;15782.526524204291;15942.28259728315;2115.862468939514;2116.47088227943;2148.119271098842;2148.8213405692363;2205.3935167828813;67742;74009;75986;86821.56589217014;99129.5043524785;17864.55338616545;18543.258269669062;18844.717329240073;18903.43289701311;19190.904045479685;33230.50154247688;33290.167745806066;33302.16744581356;33344.49983250253;33532.161695957795;8998.346877683862;9080.273578113734;9136.314776391664;9317.208037316768;9408.294377921684;7406.370458510979;7441.367483763833;7460.776176714708;7593.620318984029;7599.240075992357;9087.772805679911;9324.207442367475;9341.3928094675;9429.669961551313;9506.857397139049;3395.7435748773114;3469.548958635361;3547.5388199533895;3709.962900370962;3750.474933509311;436.40212908315175;438.32279128746165;845.7378212754066;879.7492714576443;958.5159494455255;11313.83029254562;11459.77080458386;11668.241564298294;11685.474153663106;11769;427.5766990679205;453.2317721462156;453.5238000099882;463.55498721227326;474.87415834803807;6553.049807777846;6608.636524991076;6612.206535215805;6634.83412914681;6640.369164929324;431673;445895;448044;455589;458494;56323.15515267274;87425;88796.5560172195;91205;93122.53438732763;494.60431654676114;501.74912543728135;503.7254696190658;507.02903938957223;507.49504243277437;11541.596044138414;11579.13156513248;11610.12924030718;11654.417279136178;11845;41690.79154604329;42090;42639.36040959326;42660;44108.33837492376;60152.39847601468;61097;61341.079883802675;62003.069953949824;62085.379146209765;5963.075723262901;6342.302346741947;8532.274756645505;8761.080086590817;9259;12986;13339;13401.12892662013;13485.460581576626;13768.793468097787;11863.288202707865;12147.453364598437;12175;12241;12290.446929887998;5942.970285148546;10144.49277536135;11881.881181188422;12326.198797078161;12466.87533124657;11787.324119038725;11929.701757456132;12015.279083255033;12099.33453660057;12458.252504849375;8606.44058136219;8762.255208307366;8791.692290769792;8855.512946787989;9069.501177435304;10185.694429167137;12515.436805343963;12524.499020039097;12528.373581320715;12661.430235639235 00:54:28 INFO - PROCESS | 27631 | |3;mootools.html;1498.3706843125883;1528.8644217391954;1682.8317168283165;1822.690142675745;1831.9542011449703;8655.480671159727;9007.189352958232;9008.954955225232;9045.231155351794;9050.683226087089;7847.293743563078;8123.187681231874;8576.699815506443;8766.605502752376;8808.339374546902;2524.2174925773024;2544.2875994721508;2546.694396672402;2548;2554.425254317782;2481.751824817522;2570.1133109077336;2570.640110384548;2570.7686308232255;2572.2283315005516;2499.5875680512695;2509.121807367425;2548.1463709657287;2550.4389034412397;2557.437363779975;2390.2112302940077;2409.0363854458183;2412.49337639096;2445.572024895654;2445.7065152181676;2438.878056097206;2483.913063042785;2499.8625075620835;2500.862452565108;2515.76100270474;8936.910630893737;9050.140236677506;9076.455412675261;9108.544572771334;9110.726678199664;5439.728013599344;5583.637063590853;5587.469190426903;5588.888222235573;5589.888202235973;3394.6435624259343;3573.2496175802853;3586.8027258500774;3591.317649646559;3622.2393297407575;1065.4672663668166;1066.4827558634056;1079.4710591810035;1096.5887792077972;1139.5669645534726;12391.070669699808;12479.812802807965;12486.12597118202;12490.687732806662;12496.500139994389;4850.902981940341;5078.695278283315;5127.025865085622;5137.8201762938115;5162;10536.631217907336;10542.262041657164;10547.050765431148;10555.577776888991;10564.788704225872;5658.830235092953;5669.433056694297;5671;5671.716414179275;5674.177244299636;4655.092257009851;4961.727105009187;5144.6398752087;5196.1166601677805;5232.319798426256;4131.091159944807;4195.832166713359;4238.173556156582;4276.8289268429535;4289.1636130954785;1380.0822453068597;1423.352374669523;1427.129451034868;1429.5139652517985;1435.9353829077716;790.1900551934199;835.6740871060291;926.8563372677246;927.888653361601;933.3419938943028;5556.194351818964;5607.327120745536;5794.710264486759;5799.2750906136735;5835.679037652885;958.1711819276276;969.3069455339466;991.7818080022383;991.965281215154;998.7952469743685;3616.1863580694658;3684.5025921500255;3730.5336832895887;3791.1280405506886;3899.5515515716056;10611;10817.891821081847;10884.782304353868;10955.068819150301;10955.068819150301;10388.792224155626;10805.891941080488;10859.78280434387;10865.728356790985;10910.836337454944;8111.675532978615;8352.707655232038;8380.664773408995;8393.496390216607;8425.452345597516;5276.762545685377;5660.264165658603;5690.402507736628;5702.914456283242;5795.594308398372;9850.261230407605;9874.901250987397;9896.158826499828;9941.403515789076;9970.152537034433;9815.214782817215;9961.252906031932;10100.090991810772;10279.94860025725;10335.689929302132;8060.879086813819;8206.22040906113;8240.83518329642;8245.79385515367;8252.504849709037;8250.422470427013;8594.796728457895;8742.868856967278;8766.868496972424;8770.956145219234;7712.5758083305955;7725.49784264021;7762.146163921851;7762.729742369945;7791.220877912164;7507.512011719221;7549.131849837119;7552.509086909334;7618.771436856903;7666.118396384487;6935.826604334932;6994.845850434621;7002.299770023161;7052.435805135474;7101.041359416619;4710.199266124836;4812.951870481391;4832.420109586872;4859.562639362333;4876.414830220397;4621.6302695784925;4727.57451829337;4727.858164255078;4777.689450185727;4794.520547945178 00:54:28 INFO - PROCESS | 27631 | |4;prototype.html;357.1660173494889;362.7424528584705;364.09703934243066;367.7940353402097;372.1087994253762;5300.549453296469;5322.308099947011;5325.813596524117;5351.170568561879;5356.143017117257;5268.762905669245;5271.68207948013;5281.287026251464;5286.762095705692;5288.576913846892;3905.5899130591233;4055.858044968427;4076.164386300816;4173.269677806387;4221.387898754679;4212.08350200658;4223.606209950724;4227.788610569474;4232.703710740249;4245.257080010986;4178.498580170384;4193.748375097504;4198.223328684203;4204.07510347723;4210.5578914213875;3904.4728961590104;3984.8406063757416;4156.875293741193;4162.438070860426;4173.97913010433;3699.7780133192095;3730.011546940063;3733.4213196954515;3743.270062337845;3750.3811871041516;5132.692038477703;5134.871628209287;5154.433012368637;5156.690598564098;5163.432022477525;4522.23122069249;4701.412323459567;4730.905381892378;4771.713697178146;4774.832880849153;5491.341039075297;5493.313335833021;5504.80733174337;5509.614326997072;5520.696361700105;4065.451164092839;4077.97961010196;4079.0414252650603;4090.0592863641527;4095.7747323897174;5471.94801949269;5625.54995600351;5657.434256574392;5675.091985282376;5682.772689092431;4140.730852494578;4152.91694166115;4157.438745769283;4169.249535083653;4173.97913010433;4208.789560521962;4210.379004083388;4211.7262377945335;4214.136102099063;4223.303154979394;4583.54164583539;4694.554017368345;4712.316714076508;4753.643476739258;4777.808887644455;5487.2317875497465;5515.848818960609;5521.199426083195;5526.447355264441;5539.778408863681;1386.1544457880684;1405.7980426734994;1406.790160462002;1408.401429392504;1409.605310513058;935.0696057422907;983.8622592836865;988.8282385373356;990.8216521026285;997.2271489595477;5105.463926287686;5208.166693329049;5222.843314700565;5229.267902493654;5229.47705229474;5570.440276722443;5625.8593535161945;5681.971590142106;5682.40334764852;5692.345380281321;5204.8959020819375;5275.57795376369;5306.177542480922;5308.885134121878;5322.441143679858;2877.424515096989;2911.068458093432;2913.4027524357457;2914.781391395654;2916.620839290921;5595.664260144405;5606.074997625427;5614.29821272341;5626.578006649518;5639.210510528529;5330.534103121672;5549.278593782863;5569.443055694479;5622.634528755618;5644.6330988485615;5583.35791383996;5583.497485226349;5597.776088956396;5601.943980560224;5603.467670571289;5303.4696530346655;5460.781568737206;5477.507024367826;5479.808206712746;5487.506124448819;5377.758000889891;5387.81142660005;5409.2427060212385;5413.67059258561;5428.37573679032;5601.327840659147;5609.391632890725;5614.831555053355;5634.211210430625;5640.492355688008;3885.222955408986;3968.2857085724845;4016.9598304016586;4052.8378864845076;4075.838386059959;5397.244385786072;5469.234307196916;5485.314335708036;5500.477454641803;5503.3120859892515;5311.787528498971;5374.892502150014;5395.325584301962;5398.838034858961;5410.458954104558;5071.492850714899;5327.614820146712;5374.865628359323;5391.433899440659;5398.676079435247;5340.813071542478;5363.19552067193;5366.543843773166;5373.328333958255;5376.354837419534;5328.600354973315;5397.8920421590565;5419.756110974937;5483.791981690755;5544.1960915667805;5425.647332923348;5458.235846981346;5460.5085542301385;5466.207399926909;5466.808661696821 00:54:28 INFO - PROCESS | 27631 | |5;yui.html;785.7289235213852;815.8980127484065;831.5966756123279;849.927756140728;909.6225066597362;14305.92847035766;15691.921540392297;15811.525654230363;15813.367465301375;15848.841511584895;14816.333265003073;14939.327730252138;15185.240737963113;15547.766783498228;15677.921610391932;736.1571001203619;858.1761508951414;876.0757400942035;876.4259410086372;876.8597024476085;740.8481261341412;827.0736774812219;849.2102344819316;853.036069241756;865.2991077227434;894.7941973346134;896.0949441064539;896.1083721696921;897.3942588752599;897.6902968475865;765.9846803063907;888.8000199955023;889.924356429701;890.2566357091804;890.3233542507676;572.7995201679421;647.1393047247198;656.8423578341211;657.3722095398882;665.5640555436197;14119.929400352932;14134.293285335692;14149.221792801392;14156.716865662629;14175.71648567023;13629.182249064988;13968.092074015156;14193.78709319361;14215.43138274478;14222.573322800332;12829.323027053983;12978.091533592653;12988.28564428956;13202.33988300581;13264.403101860344;4467.486239082515;4471;4495.46054473462;4568.611668008223;4572.519885412017;60341.094883576785;61386.38613613896;61521.69239153821;61605.691971540306;61606.383936160964;11076.197565154735;11106.278091924;11196.440177991068;11318.830217546743;11514.76970460586;19006.904965475085;19012.334568290044;19044;19050.52373690669;19105.80894191068;7663.540187588651;7677.731279405194;7684.154742978268;7713.4600577959;7906.802329941797;4515.435570553681;4579.244424669892;4693.460252071056;4699.342092107107;4737.644676649196;3311.4701647736247;3414.0781988863364;3418.6581341865613;3421.4525675891737;3423.9828800855835;621.6705146272392;639.9136116624196;642.2774378823823;642.9389208025231;673.7675501951917;623.628940780235;738.0810890441435;747.1892996099293;784.3450718649877;789.9170587088388;9340.673076442428;9347.532623368805;9432.73244734578;9545.809083818285;9575.425474471554;617.8949578571653;732.4140687450018;783.5063909736944;783.8980932478742;797.8125140591957;4442.955570444255;4617.884552886205;4641;4680.976595117003;4838.443578988461;83120;93423;95191;95338.52330738302;95596;49334.50665493299;66708.33291667118;81141.18858811454;83489.58255208806;88083.55958220168;73243.99999999894;74067.25932740711;74185;75310;76772;8992.28061755071;9041.909580904106;9242.768930776785;9280.071992800937;9416.670416535388;49840.501594985035;50019.249711255085;50136.74931625318;51202.74398627983;54191.18713219384;64080;64694.67652661706;67616;68036.64518945197;68906.31093688999;11331.886681133083;11335.149863760085;11571.363575003455;11593.420328983348;11837.348945808064;13457.05800593949;14233;14412.207328596609;14530.782038269223;15774.526764197093;12949.482020719066;13189.472421103048;13292.136011159244;13452.327383630975;13576;13199.802002970155;14033;14082.366293516612;14422.855771442151;14519.782203266748;12690.923749944026;13292.468301267842;13561.321933903462;13630.318484075955;13768.105073170213;10706.571737130738;11107.888921110685;11310.321380717183;11319.773604528027;11729;9762.511874406393;10947.50736216888;11075.335479871233;11235;11295.3787541686 00:54:28 INFO - PROCESS | 27631 | __end_tp_report 00:54:28 INFO - PROCESS | 27631 | __start_cc_report 00:54:28 INFO - PROCESS | 27631 | _x_x_mozilla_cycle_collect,1647 00:54:28 INFO - PROCESS | 27631 | __end_cc_report 00:54:28 INFO - PROCESS | 27631 | __startTimestamp1484902468866__endTimestamp 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | ------- Summary: start ------- 00:54:28 INFO - PROCESS | 27631 | Number of tests: 6 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#0] dojo.html Cycles:165 Average:5605.37 Median:5795.88 stddev:636.27 (11.0%) stddev-sans-first:609.01 00:54:28 INFO - PROCESS | 27631 | Values: 3175.7 3188.2 3199.7 3209.5 3235.3 5488.9 5580.7 5593.2 5649.1 5659.9 5689.8 5713.9 5727.4 5733.2 5741.3 5162.4 5184.9 5210.2 5213.4 5258.0 4959.9 5249.8 5254.5 5265.9 5270.7 4941.4 5085.2 5121.4 5127.3 5141.9 5156.4 5181.5 5193.5 5256.0 5266.1 5098.6 5134.8 5216.0 5219.5 5247.2 5247.8 5281.8 5543.1 5564.7 5617.6 6002.0 6021.2 6034.9 6082.7 6102.6 6147.1 6156.7 6161.0 6166.8 6167.4 5429.1 5472.1 5474.4 5536.9 5610.9 6052.2 6067.4 6067.5 6081.5 6084.4 5845.3 5848.6 5851.9 5857.2 5860.8 5741.8 5795.9 6036.6 6082.1 6087.9 6109.8 6129.3 6129.7 6131.9 6132.4 6091.4 6132.3 6137.0 6146.9 6162.8 4504.6 4565.9 4661.7 4680.0 4784.7 4144.0 4167.4 4190.6 4195.1 4202.2 5692.3 5695.4 5698.8 5700.6 5705.0 5776.6 5836.3 5995.6 6107.3 6113.5 5614.4 5684.3 5687.7 5712.5 5717.4 5204.9 5208.0 5209.5 5212.1 5212.1 5947.5 6000.7 6192.5 6233.5 6248.4 5956.6 5961.2 6004.4 6060.8 6092.8 6149.1 6165.8 6181.7 6182.2 6183.9 5735.9 5884.7 5884.9 5921.1 5946.9 5849.2 6039.4 6039.9 6111.8 6128.2 5977.5 6024.2 6031.4 6037.2 6037.9 5966.7 5977.3 5977.5 5978.9 5999.1 5627.7 5693.1 5908.1 5928.4 5956.7 6038.1 6039.7 6052.4 6081.5 6086.1 5601.1 5655.7 5902.4 5912.5 5924.9 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#1] ext.html Cycles:180 Average:56601.70 Median:3760.59 stddev:109200.95 (2903.8%) stddev-sans-first:109426.20 00:54:28 INFO - PROCESS | 27631 | Values: 550.9 610.4 638.4 654.2 655.7 32483.5 35555.8 35573.5 42567.6 43365.3 44122.0 44499.0 44531.6 44543.0 44566.6 8856.0 8935.6 9000.7 9002.0 9005.8 8442.7 8668.9 8828.1 10564.0 10823.6 10903.2 10933.6 10953.8 10958.1 10967.2 10708.4 10746.8 10802.1 10816.0 10817.5 10654.6 10692.6 10712.8 10714.7 10720.9 42262.4 42567.8 42639.6 42733.0 42775.4 3720.3 3822.2 3826.6 3881.3 4175.5 31135.4 32843.8 33484.7 33731.2 34277.7 4292.9 4294.5 4323.4 4500.6 4542.6 337763.0 339060.0 342926.0 342950.0 346690.0 39001.0 39955.2 66141.0 66899.0 66978.0 41832.4 41953.8 41970.2 41977.0 42015.2 15174.0 15277.2 15318.3 15331.1 15386.1 10692.4 12037.2 12039.8 12052.3 12060.6 9101.9 9386.8 9748.7 9759.3 9840.4 3760.3 3760.9 3829.8 3864.5 3880.7 1061.7 1077.1 1082.6 1156.5 1167.9 32597.3 32928.7 32957.0 33154.0 33899.5 1025.4 1108.2 1131.1 1197.5 1220.8 14597.9 17014.8 17375.9 17399.8 17493.7 503291.0 504772.0 507541.0 508276.0 508654.0 58190.9 58523.0 58591.4 58609.1 58693.4 1307.2 1341.3 1380.6 1413.3 1428.2 30629.0 32398.4 33330.3 33431.5 33550.8 49277.5 49614.0 49854.0 49870.0 49926.3 367876.0 368964.0 371676.0 372458.0 372686.0 29555.0 30286.1 30614.7 31951.8 31967.2 47658.3 48282.3 48331.0 48492.0 52466.7 41000.0 41177.0 41275.4 41433.0 43041.6 40391.6 40740.0 40990.4 41174.6 42410.8 40005.8 40170.8 40304.8 40565.4 41451.8 35496.3 36857.6 37251.0 37306.8 37852.0 27173.2 28067.6 28139.9 28409.3 28421.6 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#2] jquery.html Cycles:180 Average:28243.87 Median:437.36 stddev:73986.60 (16916.5%) stddev-sans-first:74164.62 00:54:28 INFO - PROCESS | 27631 | Values: 400.4 419.2 422.2 426.6 430.2 17331.4 19424.4 19853.8 19952.9 20005.1 19389.0 19776.7 19827.0 19977.9 20105.3 4802.4 5631.6 5652.3 5796.5 5847.9 5730.3 5816.9 5822.9 5823.6 5824.6 5681.9 5732.3 5767.4 5795.0 5826.4 5562.2 5763.5 5797.9 5798.9 5827.6 5207.5 5239.8 5245.3 5246.8 5248.1 22230.9 22379.6 22559.9 22809.2 23346.1 2412.3 2476.8 2520.4 2611.7 3135.2 15399.9 15739.0 15780.8 15782.5 15942.3 2115.9 2116.5 2148.1 2148.8 2205.4 67742.0 74009.0 75986.0 86821.6 99129.5 17864.6 18543.3 18844.7 18903.4 19190.9 33230.5 33290.2 33302.2 33344.5 33532.2 8998.3 9080.3 9136.3 9317.2 9408.3 7406.4 7441.4 7460.8 7593.6 7599.2 9087.8 9324.2 9341.4 9429.7 9506.9 3395.7 3469.5 3547.5 3710.0 3750.5 436.4 438.3 845.7 879.7 958.5 11313.8 11459.8 11668.2 11685.5 11769.0 427.6 453.2 453.5 463.6 474.9 6553.0 6608.6 6612.2 6634.8 6640.4 431673.0 445895.0 448044.0 455589.0 458494.0 56323.2 87425.0 88796.6 91205.0 93122.5 494.6 501.7 503.7 507.0 507.5 11541.6 11579.1 11610.1 11654.4 11845.0 41690.8 42090.0 42639.4 42660.0 44108.3 60152.4 61097.0 61341.1 62003.1 62085.4 5963.1 6342.3 8532.3 8761.1 9259.0 12986.0 13339.0 13401.1 13485.5 13768.8 11863.3 12147.5 12175.0 12241.0 12290.4 5943.0 10144.5 11881.9 12326.2 12466.9 11787.3 11929.7 12015.3 12099.3 12458.3 8606.4 8762.3 8791.7 8855.5 9069.5 10185.7 12515.4 12524.5 12528.4 12661.4 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#3] mootools.html Cycles:180 Average:5858.66 Median:5020.21 stddev:3275.08 (65.2%) stddev-sans-first:3267.88 00:54:28 INFO - PROCESS | 27631 | Values: 1498.4 1528.9 1682.8 1822.7 1832.0 8655.5 9007.2 9009.0 9045.2 9050.7 7847.3 8123.2 8576.7 8766.6 8808.3 2524.2 2544.3 2546.7 2548.0 2554.4 2481.8 2570.1 2570.6 2570.8 2572.2 2499.6 2509.1 2548.1 2550.4 2557.4 2390.2 2409.0 2412.5 2445.6 2445.7 2438.9 2483.9 2499.9 2500.9 2515.8 8936.9 9050.1 9076.5 9108.5 9110.7 5439.7 5583.6 5587.5 5588.9 5589.9 3394.6 3573.2 3586.8 3591.3 3622.2 1065.5 1066.5 1079.5 1096.6 1139.6 12391.1 12479.8 12486.1 12490.7 12496.5 4850.9 5078.7 5127.0 5137.8 5162.0 10536.6 10542.3 10547.1 10555.6 10564.8 5658.8 5669.4 5671.0 5671.7 5674.2 4655.1 4961.7 5144.6 5196.1 5232.3 4131.1 4195.8 4238.2 4276.8 4289.2 1380.1 1423.4 1427.1 1429.5 1435.9 790.2 835.7 926.9 927.9 933.3 5556.2 5607.3 5794.7 5799.3 5835.7 958.2 969.3 991.8 992.0 998.8 3616.2 3684.5 3730.5 3791.1 3899.6 10611.0 10817.9 10884.8 10955.1 10955.1 10388.8 10805.9 10859.8 10865.7 10910.8 8111.7 8352.7 8380.7 8393.5 8425.5 5276.8 5660.3 5690.4 5702.9 5795.6 9850.3 9874.9 9896.2 9941.4 9970.2 9815.2 9961.3 10100.1 10279.9 10335.7 8060.9 8206.2 8240.8 8245.8 8252.5 8250.4 8594.8 8742.9 8766.9 8771.0 7712.6 7725.5 7762.1 7762.7 7791.2 7507.5 7549.1 7552.5 7618.8 7666.1 6935.8 6994.8 7002.3 7052.4 7101.0 4710.2 4813.0 4832.4 4859.6 4876.4 4621.6 4727.6 4727.9 4777.7 4794.5 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#4] prototype.html Cycles:180 Average:4611.24 Median:5307.53 stddev:1315.33 (24.8%) stddev-sans-first:1279.68 00:54:28 INFO - PROCESS | 27631 | Values: 357.2 362.7 364.1 367.8 372.1 5300.5 5322.3 5325.8 5351.2 5356.1 5268.8 5271.7 5281.3 5286.8 5288.6 3905.6 4055.9 4076.2 4173.3 4221.4 4212.1 4223.6 4227.8 4232.7 4245.3 4178.5 4193.7 4198.2 4204.1 4210.6 3904.5 3984.8 4156.9 4162.4 4174.0 3699.8 3730.0 3733.4 3743.3 3750.4 5132.7 5134.9 5154.4 5156.7 5163.4 4522.2 4701.4 4730.9 4771.7 4774.8 5491.3 5493.3 5504.8 5509.6 5520.7 4065.5 4078.0 4079.0 4090.1 4095.8 5471.9 5625.5 5657.4 5675.1 5682.8 4140.7 4152.9 4157.4 4169.2 4174.0 4208.8 4210.4 4211.7 4214.1 4223.3 4583.5 4694.6 4712.3 4753.6 4777.8 5487.2 5515.8 5521.2 5526.4 5539.8 1386.2 1405.8 1406.8 1408.4 1409.6 935.1 983.9 988.8 990.8 997.2 5105.5 5208.2 5222.8 5229.3 5229.5 5570.4 5625.9 5682.0 5682.4 5692.3 5204.9 5275.6 5306.2 5308.9 5322.4 2877.4 2911.1 2913.4 2914.8 2916.6 5595.7 5606.1 5614.3 5626.6 5639.2 5330.5 5549.3 5569.4 5622.6 5644.6 5583.4 5583.5 5597.8 5601.9 5603.5 5303.5 5460.8 5477.5 5479.8 5487.5 5377.8 5387.8 5409.2 5413.7 5428.4 5601.3 5609.4 5614.8 5634.2 5640.5 3885.2 3968.3 4017.0 4052.8 4075.8 5397.2 5469.2 5485.3 5500.5 5503.3 5311.8 5374.9 5395.3 5398.8 5410.5 5071.5 5327.6 5374.9 5391.4 5398.7 5340.8 5363.2 5366.5 5373.3 5376.4 5328.6 5397.9 5419.8 5483.8 5544.2 5425.6 5458.2 5460.5 5466.2 5466.8 00:54:28 INFO - PROCESS | 27631 | 00:54:28 INFO - PROCESS | 27631 | [#5] yui.html Cycles:180 Average:18382.02 Median:49929.88 stddev:24475.81 (49.0%) stddev-sans-first:24508.81 00:54:28 INFO - PROCESS | 27631 | Values: 785.7 815.9 831.6 849.9 909.6 14305.9 15691.9 15811.5 15813.4 15848.8 14816.3 14939.3 15185.2 15547.8 15677.9 736.2 858.2 876.1 876.4 876.9 740.8 827.1 849.2 853.0 865.3 894.8 896.1 896.1 897.4 897.7 766.0 888.8 889.9 890.3 890.3 572.8 647.1 656.8 657.4 665.6 14119.9 14134.3 14149.2 14156.7 14175.7 13629.2 13968.1 14193.8 14215.4 14222.6 12829.3 12978.1 12988.3 13202.3 13264.4 4467.5 4471.0 4495.5 4568.6 4572.5 60341.1 61386.4 61521.7 61605.7 61606.4 11076.2 11106.3 11196.4 11318.8 11514.8 19006.9 19012.3 19044.0 19050.5 19105.8 7663.5 7677.7 7684.2 7713.5 7906.8 4515.4 4579.2 4693.5 4699.3 4737.6 3311.5 3414.1 3418.7 3421.5 3424.0 621.7 639.9 642.3 642.9 673.8 623.6 738.1 747.2 784.3 789.9 9340.7 9347.5 9432.7 9545.8 9575.4 617.9 732.4 783.5 783.9 797.8 4443.0 4617.9 4641.0 4681.0 4838.4 83120.0 93423.0 95191.0 95338.5 95596.0 49334.5 66708.3 81141.2 83489.6 88083.6 73244.0 74067.3 74185.0 75310.0 76772.0 8992.3 9041.9 9242.8 9280.1 9416.7 49840.5 50019.2 50136.7 51202.7 54191.2 64080.0 64694.7 67616.0 68036.6 68906.3 11331.9 11335.1 11571.4 11593.4 11837.3 13457.1 14233.0 14412.2 14530.8 15774.5 12949.5 13189.5 13292.1 13452.3 13576.0 13199.8 14033.0 14082.4 14422.9 14519.8 12690.9 13292.5 13561.3 13630.3 13768.1 10706.6 11107.9 11310.3 11319.8 11729.0 9762.5 10947.5 11075.3 11235.0 11295.4 00:54:28 INFO - PROCESS | 27631 | -------- Summary: end -------- 00:54:28 INFO - PROCESS | 27631 | 00:54:29 INFO - TEST-INFO | 27631: exit 0 00:54:29 INFO - TEST-OK | dromaeo_css | took 1115308ms 00:54:29 INFO - TEST-START | kraken 00:54:29 INFO - operating with platform_type : linux_ 00:54:29 INFO - Initialising browser for kraken test... 00:54:29 INFO - TEST-INFO | started process 27951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4ZC1e/profile http://localhost:48404/getInfo.html) 00:54:33 INFO - PROCESS | 27951 | __metrics Screen width/height:1600/1200 00:54:33 INFO - PROCESS | 27951 | colorDepth:24 00:54:33 INFO - PROCESS | 27951 | Browser inner width/height: 1024/697 00:54:33 INFO - PROCESS | 27951 | __metrics 00:54:34 INFO - PROCESS | 27951 | 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" 00:54:34 INFO - PROCESS | 27951 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:54:34 INFO - PROCESS | 27951 | console.error: PushService: 00:54:34 INFO - PROCESS | 27951 | stateChangeProcessEnqueue: Error transitioning state 00:54:34 INFO - PROCESS | 27951 | UnknownError 00:54:35 INFO - TEST-INFO | 27951: exit 0 00:54:35 INFO - Browser initialized. 00:54:35 INFO - Running cycle 1/1 for kraken test... 00:54:35 INFO - TEST-INFO | started process 28044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4ZC1e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:54:47 INFO - PROCESS | 28044 | RSS: Main: 144195584 00:54:47 INFO - PROCESS | 28044 | 00:54:49 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-beat-detection) 00:54:50 INFO - PROCESS | 28044 | RSS: Main: 185348096 00:54:50 INFO - PROCESS | 28044 | 00:54:53 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-dft) 00:54:53 INFO - PROCESS | 28044 | RSS: Main: 175562752 00:54:53 INFO - PROCESS | 28044 | 00:54:56 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-fft) 00:54:57 INFO - PROCESS | 28044 | RSS: Main: 267268096 00:54:57 INFO - PROCESS | 28044 | 00:54:59 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48404/tests/kraken/driver.html?testName=audio-oscillator) 00:54:59 INFO - PROCESS | 28044 | RSS: Main: 172941312 00:54:59 INFO - PROCESS | 28044 | 00:55:01 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:55:02 INFO - PROCESS | 28044 | RSS: Main: 175218688 00:55:02 INFO - PROCESS | 28044 | 00:55:05 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-darkroom) 00:55:05 INFO - PROCESS | 28044 | RSS: Main: 214552576 00:55:05 INFO - PROCESS | 28044 | 00:55:09 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48404/tests/kraken/driver.html?testName=imaging-desaturate) 00:55:09 INFO - PROCESS | 28044 | RSS: Main: 213184512 00:55:09 INFO - PROCESS | 28044 | 00:55:12 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48404/tests/kraken/driver.html?testName=json-parse-financial) 00:55:12 INFO - PROCESS | 28044 | RSS: Main: 211804160 00:55:12 INFO - PROCESS | 28044 | 00:55:14 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:55:15 INFO - PROCESS | 28044 | RSS: Main: 173764608 00:55:15 INFO - PROCESS | 28044 | 00:55:16 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:55:17 INFO - PROCESS | 28044 | RSS: Main: 181547008 00:55:17 INFO - PROCESS | 28044 | 00:55:19 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:55:19 INFO - PROCESS | 28044 | RSS: Main: 190427136 00:55:19 INFO - PROCESS | 28044 | 00:55:22 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:55:23 INFO - PROCESS | 28044 | RSS: Main: 199151616 00:55:23 INFO - PROCESS | 28044 | 00:55:25 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:55:26 INFO - PROCESS | 28044 | RSS: Main: 194654208 00:55:26 INFO - PROCESS | 28044 | 00:55:27 INFO - PROCESS | 28044 | Cycle 1(1): loaded http://localhost:48404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48404/tests/kraken/driver.html?testName=ai-astar) 00:55:28 INFO - PROCESS | 28044 | RSS: Main: 246382592 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | __start_tp_report 00:55:28 INFO - PROCESS | 28044 | _x_x_mozilla_page_load 00:55:28 INFO - PROCESS | 28044 | _x_x_mozilla_page_load_details 00:55:28 INFO - PROCESS | 28044 | |i|pagename|runs| 00:55:28 INFO - PROCESS | 28044 | |0;ai-astar;101;110;113;110;111;113;111;112;112;111 00:55:28 INFO - PROCESS | 28044 | |1;audio-beat-detection;146;120;119;163;121;121;122;117;158;119 00:55:28 INFO - PROCESS | 28044 | |2;audio-dft;159;160;160;161;158;159;160;160;159;159 00:55:28 INFO - PROCESS | 28044 | |3;audio-fft;74;75;75;110;76;76;75;76;106;76 00:55:28 INFO - PROCESS | 28044 | |4;audio-oscillator;83;81;110;82;83;82;111;83;81;116 00:55:28 INFO - PROCESS | 28044 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;117;116 00:55:28 INFO - PROCESS | 28044 | |6;imaging-darkroom;146;147;147;146;146;147;146;146;147;146 00:55:28 INFO - PROCESS | 28044 | |7;imaging-desaturate;84;84;84;85;84;84;84;85;85;84 00:55:28 INFO - PROCESS | 28044 | |8;json-parse-financial;51;52;54;50;51;55;51;52;50;53 00:55:28 INFO - PROCESS | 28044 | |9;json-stringify-tinderbox;58;59;59;58;60;59;59;58;58;59 00:55:28 INFO - PROCESS | 28044 | |10;stanford-crypto-aes;77;75;76;74;75;74;75;75;77;74 00:55:28 INFO - PROCESS | 28044 | |11;stanford-crypto-ccm;124;129;127;120;125;121;119;118;165;127 00:55:28 INFO - PROCESS | 28044 | |12;stanford-crypto-pbkdf2;152;149;149;148;157;152;150;153;152;151 00:55:28 INFO - PROCESS | 28044 | |13;stanford-crypto-sha256-iterative;62;63;62;62;61;63;63;61;61;60 00:55:28 INFO - PROCESS | 28044 | __end_tp_report 00:55:28 INFO - PROCESS | 28044 | __start_cc_report 00:55:28 INFO - PROCESS | 28044 | _x_x_mozilla_cycle_collect,1599 00:55:28 INFO - PROCESS | 28044 | __end_cc_report 00:55:28 INFO - PROCESS | 28044 | __startTimestamp1484902528244__endTimestamp 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | ------- Summary: start ------- 00:55:28 INFO - PROCESS | 28044 | Number of tests: 14 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.47 (3.1%) stddev-sans-first:1.13 00:55:28 INFO - PROCESS | 28044 | Values: 101.0 110.0 113.0 110.0 111.0 113.0 111.0 112.0 112.0 111.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:121.50 stddev:17.83 (14.7%) stddev-sans-first:18.02 00:55:28 INFO - PROCESS | 28044 | Values: 146.0 120.0 119.0 163.0 121.0 121.0 122.0 117.0 158.0 119.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#2] audio-dft Cycles:10 Average:159.50 Median:160.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 00:55:28 INFO - PROCESS | 28044 | Values: 159.0 160.0 160.0 161.0 158.0 159.0 160.0 160.0 159.0 159.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:13.80 (18.3%) stddev-sans-first:14.34 00:55:28 INFO - PROCESS | 28044 | Values: 74.0 75.0 75.0 110.0 76.0 76.0 75.0 76.0 106.0 76.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.68 (17.9%) stddev-sans-first:15.27 00:55:28 INFO - PROCESS | 28044 | Values: 83.0 81.0 110.0 82.0 83.0 82.0 111.0 83.0 81.0 116.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 00:55:28 INFO - PROCESS | 28044 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 00:55:28 INFO - PROCESS | 28044 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 00:55:28 INFO - PROCESS | 28044 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 85.0 84.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.66 (3.2%) stddev-sans-first:1.73 00:55:28 INFO - PROCESS | 28044 | Values: 51.0 52.0 54.0 50.0 51.0 55.0 51.0 52.0 50.0 53.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 00:55:28 INFO - PROCESS | 28044 | Values: 58.0 59.0 59.0 58.0 60.0 59.0 59.0 58.0 58.0 59.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.14 (1.5%) stddev-sans-first:1.00 00:55:28 INFO - PROCESS | 28044 | Values: 77.0 75.0 76.0 74.0 75.0 74.0 75.0 75.0 77.0 74.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.00 stddev:13.70 (10.9%) stddev-sans-first:14.47 00:55:28 INFO - PROCESS | 28044 | Values: 124.0 129.0 127.0 120.0 125.0 121.0 119.0 118.0 165.0 127.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:152.00 stddev:2.58 (1.7%) stddev-sans-first:2.73 00:55:28 INFO - PROCESS | 28044 | Values: 152.0 149.0 149.0 148.0 157.0 152.0 150.0 153.0 152.0 151.0 00:55:28 INFO - PROCESS | 28044 | 00:55:28 INFO - PROCESS | 28044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 00:55:28 INFO - PROCESS | 28044 | Values: 62.0 63.0 62.0 62.0 61.0 63.0 63.0 61.0 61.0 60.0 00:55:28 INFO - PROCESS | 28044 | -------- Summary: end -------- 00:55:28 INFO - PROCESS | 28044 | 00:55:29 INFO - TEST-INFO | 28044: exit 0 00:55:29 INFO - TEST-OK | kraken | took 59820ms 00:55:29 INFO - SUITE-END | took 1175s 00:55:29 INFO - Completed test suite (00:19:35) 00:55:29 INFO - javascript benchmark 00:55:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.7452208931672, 3188.171075520365, 3199.712025917667, 3209.4864821628544, 3235.2558911450374, 5488.917666235005, 5580.665160090387, 5593.244911936888, 5649.124385720214, 5659.915101273474, 5689.800856970007, 5713.914291285623, 5727.398623144572, 5733.226014488043, 5741.253637027181, 5162.406323272815, 5184.948150518503, 5210.16637338026, 5213.3743950725775, 5258.0, 4959.851204463872, 5249.790008399659, 5254.527092561688, 5265.9473405266035, 5270.736463176845, 4941.382327209099, 5085.1863701807715, 5121.4110377306715, 5127.307813445174, 5141.948580514184, 5156.407013193474, 5181.455947125554, 5193.480651934814, 5255.973720131413, 5266.078436273637, 5098.566621837112, 5134.8202812901745, 5216.0, 5219.5041471060185, 5247.16045432729, 5247.790088396459, 5281.8151364702435, 5543.057680194376, 5564.721763911829, 5617.606767526234, 6002.009668404708, 6021.2473440819895, 6034.879302413971, 6082.665453400061, 6102.60333078353, 6147.077938309245, 6156.6613836238985, 6160.969195154041, 6166.84582885427, 6167.444929956326, 5429.104197807396, 5472.1244600864065, 5474.37044739856, 5536.889262214733, 5610.85972850682, 6052.152698622196, 6067.393260673897, 6067.453929146398, 6081.483073938764, 6084.421979911901, 5845.298564172326, 5848.64908105515, 5851.882962340815, 5857.179994800731, 5860.765569377262, 5741.770329186869, 5795.88408231833, 6036.577439579188, 6082.148499210114, 6087.878242435127, 6109.777134817779, 6129.281740388711, 6129.667972160533, 6131.866048757567, 6132.3652053194055, 6091.400843210607, 6132.306126318478, 6136.978641397139, 6146.907796383058, 6162.815115546541, 4504.61710754583, 4565.863024109282, 4661.720296782204, 4680.017196388796, 4784.736839473862, 4144.0, 4167.437395951569, 4190.643795277436, 4195.056112374752, 4202.159568086395, 5692.288463942007, 5695.40198279183, 5698.8290351289525, 5700.629459085146, 5704.971475142598, 5776.566757493205, 5836.270466191726, 5995.550333724988, 6107.267127944675, 6113.5414843886, 5614.354349249807, 5684.346300175533, 5687.7156142192725, 5712.485876271156, 5717.399673034354, 5204.8959020819375, 5207.973960130251, 5209.505097015777, 5212.061828870764, 5212.061828870839, 5947.524198064231, 6000.729967151401, 6192.504599632109, 6233.470155036873, 6248.375162483715, 5956.553258505716, 5961.195238642901, 6004.369541198286, 6060.787872424444, 6092.75628974836, 6149.08007849457, 6165.784197553064, 6181.690915454299, 6182.227221597301, 6183.876322473436, 5735.8566035849435, 5884.676342801187, 5884.882302354014, 5921.111833225051, 5946.881062378641, 5849.151872978309, 6039.4262545058145, 6039.879202415839, 6111.786087486917, 6128.167033931239, 5977.5217982560425, 6024.156618073385, 6031.366706495754, 6037.18498002764, 6037.879242415215, 5966.731497082555, 5977.282726072899, 5977.491913187428, 5978.940210597838, 5999.130126131599, 5627.718614069198, 5693.089105743061, 5908.084246941731, 5928.407159284209, 5956.702164891652, 6038.064100064497, 6039.698015099139, 6052.425019623129, 6081.513478921587, 6086.147939288415, 5601.103823388238, 5655.688937108334, 5902.4097590240635, 5912.46787789101, 5924.940750592611], "value": 5562.281891982475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9338879334481, 610.4079043327972, 638.3584497579932, 654.2443477783162, 655.7278729327329, 32483.51274730878, 35555.82222088889, 35573.46639800405, 42567.57432425683, 43365.34951975715, 44122.0, 44499.0, 44531.55468445315, 44543.0, 44566.55433445665, 8855.955720221405, 8935.64257429702, 9000.729978100635, 9002.0, 9005.77485562863, 8442.662293508252, 8668.913310866905, 8828.117188281185, 10564.0, 10823.621173258938, 10903.182261330392, 10933.56265749369, 10953.83569246462, 10958.123350131971, 10967.232293739442, 10708.357498550073, 10746.838797418044, 10802.081823045051, 10816.0, 10817.513211905483, 10654.573817047309, 10692.572297108107, 10712.78574428515, 10714.678559643224, 10720.892791072067, 42262.36606450906, 42567.787161064, 42639.57360426387, 42733.0, 42775.35836962448, 3720.311742327678, 3822.2355528894054, 3826.617338266179, 3881.2819628368843, 4175.498940127204, 31135.37729245425, 32843.83578082094, 33484.6651533484, 33731.15672108193, 34277.6572234277, 4292.935605965913, 4294.506131794852, 4323.351497275403, 4500.639948804121, 4542.6138778203895, 337763.0, 339060.0, 342926.0, 342950.0, 346690.0, 39001.0, 39955.200895981914, 66141.0, 66899.0, 66977.98599063054, 41832.37251441231, 41953.79023104926, 41970.160596788504, 41977.0, 42015.159696805895, 15174.0, 15277.236138193046, 15318.310676019606, 15331.080135191924, 15386.07683538969, 10692.358458492516, 12037.157398981988, 12039.819402708967, 12052.276863388224, 12060.638180854588, 9101.863472047924, 9386.765330866647, 9748.658796942073, 9759.316847820584, 9840.409575425498, 3760.304343696425, 3760.8683696070507, 3829.8468061277235, 3864.478295430137, 3880.7387599030426, 1061.7153244573997, 1077.1329080090602, 1082.6210826210763, 1156.5431654496426, 1167.8832116788253, 32597.348053038808, 32928.67071329256, 32957.0, 33154.0, 33899.491507627405, 1025.380407162717, 1108.2076315434504, 1131.134681968295, 1197.467127128437, 1220.7619514194646, 14597.92701036488, 17014.829851701572, 17375.913120434318, 17399.82600173982, 17493.650126997643, 503291.0, 504772.0, 507541.0, 508276.0, 508654.0, 58190.926635135984, 58523.0, 58591.414085858596, 58609.12086318708, 58693.41306586879, 1307.1960744142475, 1341.322632070798, 1380.5582213691723, 1413.3216056293038, 1428.243031193469, 30629.0, 32398.35203295968, 33330.33339333248, 33431.49852752162, 33550.83224583862, 49277.50722492729, 49614.0, 49854.0, 49870.0, 49926.251106234165, 367876.0, 368964.0, 371676.0, 372458.0, 372686.0, 29555.0, 30286.091417257518, 30614.693853061184, 31951.840240798647, 31967.200819979687, 47658.28512572245, 48282.275765864244, 48331.0, 48492.0, 52466.73766631143, 41000.0, 41177.0, 41275.38086928758, 41433.0, 43041.569584303754, 40391.596084038785, 40740.0, 40990.385144222266, 41174.58825411707, 42410.787946060074, 40005.79997099996, 40170.79914600408, 40304.79847600743, 40565.39151912665, 41451.7927410361, 35496.290074198885, 36857.63142368649, 37251.0, 37306.81346593249, 37852.0, 27173.184804455897, 28067.562096044156, 28139.93003498251, 28409.28976775597, 28421.573676395285], "value": 19480.381407140227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.35342921182263, 419.19514532098367, 422.1535820679536, 426.5776880887922, 430.1504528556101, 17331.39340123096, 19424.417267481964, 19853.801461985375, 19952.900235498837, 20005.099770510307, 19389.0, 19776.70334944977, 19827.0, 19977.900110499464, 20105.29631462899, 4802.447718512363, 5631.60578759487, 5652.265205523277, 5796.50729687977, 5847.912281315784, 5730.255066841326, 5816.854578635525, 5822.941770582303, 5823.563232757539, 5824.592278540504, 5681.886362272752, 5732.283464566929, 5767.394423585526, 5795.043817770063, 5826.388229235933, 5562.16567514872, 5763.5101016413655, 5797.884042319172, 5798.884022319551, 5827.621204621707, 5207.479252074762, 5239.79040838366, 5245.291885595472, 5246.7901283948595, 5248.134057880445, 22230.88884555567, 22379.55240895173, 22559.887200564055, 22809.201677941357, 23346.066157353856, 2412.2763171048614, 2476.839005464639, 2520.357308886222, 2611.738826117392, 3135.2318681922848, 15399.923000384926, 15739.0, 15780.842191578053, 15782.526524204291, 15942.28259728315, 2115.862468939514, 2116.47088227943, 2148.119271098842, 2148.8213405692363, 2205.3935167828813, 67742.0, 74009.0, 75986.0, 86821.56589217014, 99129.5043524785, 17864.55338616545, 18543.258269669062, 18844.717329240073, 18903.43289701311, 19190.904045479685, 33230.50154247688, 33290.167745806066, 33302.16744581356, 33344.49983250253, 33532.161695957795, 8998.346877683862, 9080.273578113734, 9136.314776391664, 9317.208037316768, 9408.294377921684, 7406.370458510979, 7441.367483763833, 7460.776176714708, 7593.620318984029, 7599.240075992357, 9087.772805679911, 9324.207442367475, 9341.3928094675, 9429.669961551313, 9506.857397139049, 3395.7435748773114, 3469.548958635361, 3547.5388199533895, 3709.962900370962, 3750.474933509311, 436.40212908315175, 438.32279128746165, 845.7378212754066, 879.7492714576443, 958.5159494455255, 11313.83029254562, 11459.77080458386, 11668.241564298294, 11685.474153663106, 11769.0, 427.5766990679205, 453.2317721462156, 453.5238000099882, 463.55498721227326, 474.87415834803807, 6553.049807777846, 6608.636524991076, 6612.206535215805, 6634.83412914681, 6640.369164929324, 431673.0, 445895.0, 448044.0, 455589.0, 458494.0, 56323.15515267274, 87425.0, 88796.5560172195, 91205.0, 93122.53438732763, 494.60431654676114, 501.74912543728135, 503.7254696190658, 507.02903938957223, 507.49504243277437, 11541.596044138414, 11579.13156513248, 11610.12924030718, 11654.417279136178, 11845.0, 41690.79154604329, 42090.0, 42639.36040959326, 42660.0, 44108.33837492376, 60152.39847601468, 61097.0, 61341.079883802675, 62003.069953949824, 62085.379146209765, 5963.075723262901, 6342.302346741947, 8532.274756645505, 8761.080086590817, 9259.0, 12986.0, 13339.0, 13401.12892662013, 13485.460581576626, 13768.793468097787, 11863.288202707865, 12147.453364598437, 12175.0, 12241.0, 12290.446929887998, 5942.970285148546, 10144.49277536135, 11881.881181188422, 12326.198797078161, 12466.87533124657, 11787.324119038725, 11929.701757456132, 12015.279083255033, 12099.33453660057, 12458.252504849375, 8606.44058136219, 8762.255208307366, 8791.692290769792, 8855.512946787989, 9069.501177435304, 10185.694429167137, 12515.436805343963, 12524.499020039097, 12528.373581320715, 12661.430235639235], "value": 9207.020431442754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.3706843125883, 1528.8644217391954, 1682.8317168283165, 1822.690142675745, 1831.9542011449703, 8655.480671159727, 9007.189352958232, 9008.954955225232, 9045.231155351794, 9050.683226087089, 7847.293743563078, 8123.187681231874, 8576.699815506443, 8766.605502752376, 8808.339374546902, 2524.2174925773024, 2544.2875994721508, 2546.694396672402, 2548.0, 2554.425254317782, 2481.751824817522, 2570.1133109077336, 2570.640110384548, 2570.7686308232255, 2572.2283315005516, 2499.5875680512695, 2509.121807367425, 2548.1463709657287, 2550.4389034412397, 2557.437363779975, 2390.2112302940077, 2409.0363854458183, 2412.49337639096, 2445.572024895654, 2445.7065152181676, 2438.878056097206, 2483.913063042785, 2499.8625075620835, 2500.862452565108, 2515.76100270474, 8936.910630893737, 9050.140236677506, 9076.455412675261, 9108.544572771334, 9110.726678199664, 5439.728013599344, 5583.637063590853, 5587.469190426903, 5588.888222235573, 5589.888202235973, 3394.6435624259343, 3573.2496175802853, 3586.8027258500774, 3591.317649646559, 3622.2393297407575, 1065.4672663668166, 1066.4827558634056, 1079.4710591810035, 1096.5887792077972, 1139.5669645534726, 12391.070669699808, 12479.812802807965, 12486.12597118202, 12490.687732806662, 12496.500139994389, 4850.902981940341, 5078.695278283315, 5127.025865085622, 5137.8201762938115, 5162.0, 10536.631217907336, 10542.262041657164, 10547.050765431148, 10555.577776888991, 10564.788704225872, 5658.830235092953, 5669.433056694297, 5671.0, 5671.716414179275, 5674.177244299636, 4655.092257009851, 4961.727105009187, 5144.6398752087, 5196.1166601677805, 5232.319798426256, 4131.091159944807, 4195.832166713359, 4238.173556156582, 4276.8289268429535, 4289.1636130954785, 1380.0822453068597, 1423.352374669523, 1427.129451034868, 1429.5139652517985, 1435.9353829077716, 790.1900551934199, 835.6740871060291, 926.8563372677246, 927.888653361601, 933.3419938943028, 5556.194351818964, 5607.327120745536, 5794.710264486759, 5799.2750906136735, 5835.679037652885, 958.1711819276276, 969.3069455339466, 991.7818080022383, 991.965281215154, 998.7952469743685, 3616.1863580694658, 3684.5025921500255, 3730.5336832895887, 3791.1280405506886, 3899.5515515716056, 10611.0, 10817.891821081847, 10884.782304353868, 10955.068819150301, 10955.068819150301, 10388.792224155626, 10805.891941080488, 10859.78280434387, 10865.728356790985, 10910.836337454944, 8111.675532978615, 8352.707655232038, 8380.664773408995, 8393.496390216607, 8425.452345597516, 5276.762545685377, 5660.264165658603, 5690.402507736628, 5702.914456283242, 5795.594308398372, 9850.261230407605, 9874.901250987397, 9896.158826499828, 9941.403515789076, 9970.152537034433, 9815.214782817215, 9961.252906031932, 10100.090991810772, 10279.94860025725, 10335.689929302132, 8060.879086813819, 8206.22040906113, 8240.83518329642, 8245.79385515367, 8252.504849709037, 8250.422470427013, 8594.796728457895, 8742.868856967278, 8766.868496972424, 8770.956145219234, 7712.5758083305955, 7725.49784264021, 7762.146163921851, 7762.729742369945, 7791.220877912164, 7507.512011719221, 7549.131849837119, 7552.509086909334, 7618.771436856903, 7666.118396384487, 6935.826604334932, 6994.845850434621, 7002.299770023161, 7052.435805135474, 7101.041359416619, 4710.199266124836, 4812.951870481391, 4832.420109586872, 4859.562639362333, 4876.414830220397, 4621.6302695784925, 4727.57451829337, 4727.858164255078, 4777.689450185727, 4794.520547945178], "value": 4724.051044524153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1660173494889, 362.7424528584705, 364.09703934243066, 367.7940353402097, 372.1087994253762, 5300.549453296469, 5322.308099947011, 5325.813596524117, 5351.170568561879, 5356.143017117257, 5268.762905669245, 5271.68207948013, 5281.287026251464, 5286.762095705692, 5288.576913846892, 3905.5899130591233, 4055.858044968427, 4076.164386300816, 4173.269677806387, 4221.387898754679, 4212.08350200658, 4223.606209950724, 4227.788610569474, 4232.703710740249, 4245.257080010986, 4178.498580170384, 4193.748375097504, 4198.223328684203, 4204.07510347723, 4210.5578914213875, 3904.4728961590104, 3984.8406063757416, 4156.875293741193, 4162.438070860426, 4173.97913010433, 3699.7780133192095, 3730.011546940063, 3733.4213196954515, 3743.270062337845, 3750.3811871041516, 5132.692038477703, 5134.871628209287, 5154.433012368637, 5156.690598564098, 5163.432022477525, 4522.23122069249, 4701.412323459567, 4730.905381892378, 4771.713697178146, 4774.832880849153, 5491.341039075297, 5493.313335833021, 5504.80733174337, 5509.614326997072, 5520.696361700105, 4065.451164092839, 4077.97961010196, 4079.0414252650603, 4090.0592863641527, 4095.7747323897174, 5471.94801949269, 5625.54995600351, 5657.434256574392, 5675.091985282376, 5682.772689092431, 4140.730852494578, 4152.91694166115, 4157.438745769283, 4169.249535083653, 4173.97913010433, 4208.789560521962, 4210.379004083388, 4211.7262377945335, 4214.136102099063, 4223.303154979394, 4583.54164583539, 4694.554017368345, 4712.316714076508, 4753.643476739258, 4777.808887644455, 5487.2317875497465, 5515.848818960609, 5521.199426083195, 5526.447355264441, 5539.778408863681, 1386.1544457880684, 1405.7980426734994, 1406.790160462002, 1408.401429392504, 1409.605310513058, 935.0696057422907, 983.8622592836865, 988.8282385373356, 990.8216521026285, 997.2271489595477, 5105.463926287686, 5208.166693329049, 5222.843314700565, 5229.267902493654, 5229.47705229474, 5570.440276722443, 5625.8593535161945, 5681.971590142106, 5682.40334764852, 5692.345380281321, 5204.8959020819375, 5275.57795376369, 5306.177542480922, 5308.885134121878, 5322.441143679858, 2877.424515096989, 2911.068458093432, 2913.4027524357457, 2914.781391395654, 2916.620839290921, 5595.664260144405, 5606.074997625427, 5614.29821272341, 5626.578006649518, 5639.210510528529, 5330.534103121672, 5549.278593782863, 5569.443055694479, 5622.634528755618, 5644.6330988485615, 5583.35791383996, 5583.497485226349, 5597.776088956396, 5601.943980560224, 5603.467670571289, 5303.4696530346655, 5460.781568737206, 5477.507024367826, 5479.808206712746, 5487.506124448819, 5377.758000889891, 5387.81142660005, 5409.2427060212385, 5413.67059258561, 5428.37573679032, 5601.327840659147, 5609.391632890725, 5614.831555053355, 5634.211210430625, 5640.492355688008, 3885.222955408986, 3968.2857085724845, 4016.9598304016586, 4052.8378864845076, 4075.838386059959, 5397.244385786072, 5469.234307196916, 5485.314335708036, 5500.477454641803, 5503.3120859892515, 5311.787528498971, 5374.892502150014, 5395.325584301962, 5398.838034858961, 5410.458954104558, 5071.492850714899, 5327.614820146712, 5374.865628359323, 5391.433899440659, 5398.676079435247, 5340.813071542478, 5363.19552067193, 5366.543843773166, 5373.328333958255, 5376.354837419534, 5328.600354973315, 5397.8920421590565, 5419.756110974937, 5483.791981690755, 5544.1960915667805, 5425.647332923348, 5458.235846981346, 5460.5085542301385, 5466.207399926909, 5466.808661696821], "value": 4202.819459002928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.7289235213852, 815.8980127484065, 831.5966756123279, 849.927756140728, 909.6225066597362, 14305.92847035766, 15691.921540392297, 15811.525654230363, 15813.367465301375, 15848.841511584895, 14816.333265003073, 14939.327730252138, 15185.240737963113, 15547.766783498228, 15677.921610391932, 736.1571001203619, 858.1761508951414, 876.0757400942035, 876.4259410086372, 876.8597024476085, 740.8481261341412, 827.0736774812219, 849.2102344819316, 853.036069241756, 865.2991077227434, 894.7941973346134, 896.0949441064539, 896.1083721696921, 897.3942588752599, 897.6902968475865, 765.9846803063907, 888.8000199955023, 889.924356429701, 890.2566357091804, 890.3233542507676, 572.7995201679421, 647.1393047247198, 656.8423578341211, 657.3722095398882, 665.5640555436197, 14119.929400352932, 14134.293285335692, 14149.221792801392, 14156.716865662629, 14175.71648567023, 13629.182249064988, 13968.092074015156, 14193.78709319361, 14215.43138274478, 14222.573322800332, 12829.323027053983, 12978.091533592653, 12988.28564428956, 13202.33988300581, 13264.403101860344, 4467.486239082515, 4471.0, 4495.46054473462, 4568.611668008223, 4572.519885412017, 60341.094883576785, 61386.38613613896, 61521.69239153821, 61605.691971540306, 61606.383936160964, 11076.197565154735, 11106.278091924, 11196.440177991068, 11318.830217546743, 11514.76970460586, 19006.904965475085, 19012.334568290044, 19044.0, 19050.52373690669, 19105.80894191068, 7663.540187588651, 7677.731279405194, 7684.154742978268, 7713.4600577959, 7906.802329941797, 4515.435570553681, 4579.244424669892, 4693.460252071056, 4699.342092107107, 4737.644676649196, 3311.4701647736247, 3414.0781988863364, 3418.6581341865613, 3421.4525675891737, 3423.9828800855835, 621.6705146272392, 639.9136116624196, 642.2774378823823, 642.9389208025231, 673.7675501951917, 623.628940780235, 738.0810890441435, 747.1892996099293, 784.3450718649877, 789.9170587088388, 9340.673076442428, 9347.532623368805, 9432.73244734578, 9545.809083818285, 9575.425474471554, 617.8949578571653, 732.4140687450018, 783.5063909736944, 783.8980932478742, 797.8125140591957, 4442.955570444255, 4617.884552886205, 4641.0, 4680.976595117003, 4838.443578988461, 83120.0, 93423.0, 95191.0, 95338.52330738302, 95596.0, 49334.50665493299, 66708.33291667118, 81141.18858811454, 83489.58255208806, 88083.55958220168, 73243.99999999894, 74067.25932740711, 74185.0, 75310.0, 76772.0, 8992.28061755071, 9041.909580904106, 9242.768930776785, 9280.071992800937, 9416.670416535388, 49840.501594985035, 50019.249711255085, 50136.74931625318, 51202.74398627983, 54191.18713219384, 64080.0, 64694.67652661706, 67616.0, 68036.64518945197, 68906.31093688999, 11331.886681133083, 11335.149863760085, 11571.363575003455, 11593.420328983348, 11837.348945808064, 13457.05800593949, 14233.0, 14412.207328596609, 14530.782038269223, 15774.526764197093, 12949.482020719066, 13189.472421103048, 13292.136011159244, 13452.327383630975, 13576.0, 13199.802002970155, 14033.0, 14082.366293516612, 14422.855771442151, 14519.782203266748, 12690.923749944026, 13292.468301267842, 13561.321933903462, 13630.318484075955, 13768.105073170213, 10706.571737130738, 11107.888921110685, 11310.321380717183, 11319.773604528027, 11729.0, 9762.511874406393, 10947.50736216888, 11075.335479871233, 11235.0, 11295.3787541686], "value": 7362.755695178171, "unit": "score"}], "name": "dromaeo_css", "value": 7255.2321763309865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 113.0, 110.0, 111.0, 113.0, 111.0, 112.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 119.0, 163.0, 121.0, 121.0, 122.0, 117.0, 158.0, 119.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 161.0, 158.0, 159.0, 160.0, 160.0, 159.0, 159.0], "value": 159.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 76.0, 76.0, 75.0, 76.0, 106.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 110.0, 82.0, 83.0, 82.0, 111.0, 83.0, 81.0, 116.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 50.0, 51.0, 55.0, 51.0, 52.0, 50.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 74.0, 75.0, 74.0, 75.0, 75.0, 77.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 127.0, 120.0, 125.0, 121.0, 119.0, 118.0, 165.0, 127.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 149.0, 148.0, 157.0, 152.0, 150.0, 153.0, 152.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 61.0, 61.0, 60.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1447.8, "alertThreshold": 2.0}]} 00:55:29 INFO - Return code: 0 00:55:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:55:30 INFO - # TBPL SUCCESS # 00:55:30 INFO - Running post-action listener: _resource_record_post_action 00:55:30 INFO - [mozharness: 2017-01-20 08:55:30.047530Z] Finished run-tests step (success) 00:55:30 INFO - Running post-run listener: _resource_record_post_run 00:55:30 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 367734784; Read time: 24; Write time: 236828 00:55:30 INFO - TinderboxPrint: CPU usage
13.0% 00:55:30 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 00:55:30 INFO - TinderboxPrint: I/O write bytes / time
367,734,784 / 236,828 00:55:30 INFO - TinderboxPrint: CPU idle
8,276.8 (87.0%) 00:55:30 INFO - TinderboxPrint: CPU user
1,191.5 (12.5%) 00:55:30 INFO - TinderboxPrint: Swap in / out
0 / 0 00:55:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119107584; Read time: 0; Write time: 75156 00:55:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248627200; Read time: 8; Write time: 161672 00:55:30 INFO - Running post-run listener: _upload_blobber_files 00:55:30 INFO - Blob upload gear active. 00:55:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:55:30 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 00:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:55:31 INFO - (blobuploader) - INFO - Open directory for files ... 00:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:55:34 INFO - (blobuploader) - INFO - Done attempting. 00:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:55:35 INFO - (blobuploader) - INFO - Done attempting. 00:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:55:36 INFO - (blobuploader) - INFO - Done attempting. 00:55:36 INFO - (blobuploader) - INFO - Iteration through files over. 00:55:36 INFO - Return code: 0 00:55:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:55:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:55:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79c861771cc8d7b00962cf26d4c9e2ab8654e60ebfb9c079fdd25b8cacf328acd0bed353645644c0949df50dd1e971250f82216cdd8b5f49eedc473268bcaffc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/694ed09d07349babd72ab174c0814754a9f633172933c33580eef3aad53bfe79a74f1c077743b08371801620f8c6ebde75e52d6b4ab79ac02b865a87af406705", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d78e82f05d29c063d8c839a70a45cc1680cf4b286c207ba5c6c0f17c68a48bd3ba58a3b5128f41d29e7e62b47b95e1cdc8299a1e51f10b93c208e2681729281d"} 00:55:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:55:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:55:36 INFO - Contents: 00:55:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79c861771cc8d7b00962cf26d4c9e2ab8654e60ebfb9c079fdd25b8cacf328acd0bed353645644c0949df50dd1e971250f82216cdd8b5f49eedc473268bcaffc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/694ed09d07349babd72ab174c0814754a9f633172933c33580eef3aad53bfe79a74f1c077743b08371801620f8c6ebde75e52d6b4ab79ac02b865a87af406705", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d78e82f05d29c063d8c839a70a45cc1680cf4b286c207ba5c6c0f17c68a48bd3ba58a3b5128f41d29e7e62b47b95e1cdc8299a1e51f10b93c208e2681729281d"} 00:55:36 INFO - Running post-run listener: copy_logs_to_upload_dir 00:55:36 INFO - Copying logs to upload dir... 00:55:36 INFO - mkdir: /builds/slave/test/build/upload/logs 00:55:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.053077 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-20 00:55:36.141935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 00:55:36.147002) ========= 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=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79c861771cc8d7b00962cf26d4c9e2ab8654e60ebfb9c079fdd25b8cacf328acd0bed353645644c0949df50dd1e971250f82216cdd8b5f49eedc473268bcaffc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/694ed09d07349babd72ab174c0814754a9f633172933c33580eef3aad53bfe79a74f1c077743b08371801620f8c6ebde75e52d6b4ab79ac02b865a87af406705", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d78e82f05d29c063d8c839a70a45cc1680cf4b286c207ba5c6c0f17c68a48bd3ba58a3b5128f41d29e7e62b47b95e1cdc8299a1e51f10b93c208e2681729281d"} build_url:https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/ICbIUjxhTzisYibYe3ExvA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79c861771cc8d7b00962cf26d4c9e2ab8654e60ebfb9c079fdd25b8cacf328acd0bed353645644c0949df50dd1e971250f82216cdd8b5f49eedc473268bcaffc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/694ed09d07349babd72ab174c0814754a9f633172933c33580eef3aad53bfe79a74f1c077743b08371801620f8c6ebde75e52d6b4ab79ac02b865a87af406705", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d78e82f05d29c063d8c839a70a45cc1680cf4b286c207ba5c6c0f17c68a48bd3ba58a3b5128f41d29e7e62b47b95e1cdc8299a1e51f10b93c208e2681729281d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 00:55:36.172348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:55:36.172665) ========= 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=db0483c52d987ecb441a263b000001ad-1484901053.72750-1402121166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:55:36.256162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 00:55:36.256478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 00:55:36.256774) ========= ========= Total master_lag: 0.19 =========