builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1479952264.73 results: success (0) buildid: 20161123150736 builduid: 63ab215d18974ae997fd70b326b24b52 revision: 116d83d90ce4ca5cb214e3e33c5da6735d59b848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.728952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.729366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.729671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.751845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.752110) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 17:51:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-11-23 17:51:05 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.849663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.849990) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.900180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:04.900510) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 116d83d90ce4ca5cb214e3e33c5da6735d59b848 --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 116d83d90ce4ca5cb214e3e33c5da6735d59b848 --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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 17:51:05,602 truncating revision to first 12 chars 2016-11-23 17:51:05,602 Setting DEBUG logging. 2016-11-23 17:51:05,602 attempt 1/10 2016-11-23 17:51:05,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/116d83d90ce4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 17:51:05,925 unpacking tar archive at: mozilla-aurora-116d83d90ce4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660056 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:05.576304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:05.576602) ========= script_repo_revision: 116d83d90ce4ca5cb214e3e33c5da6735d59b848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:05.576979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:05.577242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:51:05.589466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 17:51:05.590052) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:51:06 INFO - MultiFileLogger online at 20161123 17:51:06 in /builds/slave/test 17:51:06 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 17:51:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:51:06 INFO - {'append_to_log': False, 17:51:06 INFO - 'base_work_dir': '/builds/slave/test', 17:51:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:51:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:51:06 INFO - 'branch': 'Mozilla-Aurora', 17:51:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:51:06 INFO - 'config_files': ('talos/linux_config.py',), 17:51:06 INFO - 'default_actions': ('clobber', 17:51:06 INFO - 'read-buildbot-config', 17:51:06 INFO - 'download-and-extract', 17:51:06 INFO - 'populate-webroot', 17:51:06 INFO - 'create-virtualenv', 17:51:06 INFO - 'install', 17:51:06 INFO - 'run-tests'), 17:51:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:51:06 INFO - 'download_minidump_stackwalk': True, 17:51:06 INFO - 'download_symbols': 'ondemand', 17:51:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:51:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:51:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:51:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:51:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:51:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:51:06 INFO - 'installer_path': 'installer.exe', 17:51:06 INFO - 'log_level': 'info', 17:51:06 INFO - 'log_name': 'talos', 17:51:06 INFO - 'log_to_console': True, 17:51:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:51:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:51:06 INFO - 'opt_config_files': (), 17:51:06 INFO - 'pip_index': False, 17:51:06 INFO - 'sps_profile': False, 17:51:06 INFO - 'sps_profile_interval': 0, 17:51:06 INFO - 'suite': 'dromaeojs', 17:51:06 INFO - 'system_bits': '32', 17:51:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:51:06 INFO - 'title': 'talos-linux64-ix-005', 17:51:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:51:06 INFO - 'use_talos_json': True, 17:51:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:51:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:51:06 INFO - 'work_dir': 'build'} 17:51:06 INFO - [mozharness: 2016-11-24 01:51:06.387759Z] Running clobber step. 17:51:06 INFO - Running pre-action listener: _resource_record_pre_action 17:51:06 INFO - Running main action method: clobber 17:51:06 INFO - rmtree: /builds/slave/test/build 17:51:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:51:06 INFO - Running post-action listener: _resource_record_post_action 17:51:06 INFO - [mozharness: 2016-11-24 01:51:06.847005Z] Finished clobber step (success) 17:51:06 INFO - [mozharness: 2016-11-24 01:51:06.847105Z] Running read-buildbot-config step. 17:51:06 INFO - Running pre-action listener: _resource_record_pre_action 17:51:06 INFO - Running main action method: read_buildbot_config 17:51:06 INFO - Using buildbot properties: 17:51:06 INFO - { 17:51:06 INFO - "project": "", 17:51:06 INFO - "product": "firefox", 17:51:06 INFO - "script_repo_revision": "production", 17:51:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:51:06 INFO - "repository": "", 17:51:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:51:06 INFO - "buildid": "20161123150736", 17:51:06 INFO - "pgo_build": "True", 17:51:06 INFO - "basedir": "/builds/slave/test", 17:51:06 INFO - "buildnumber": 921, 17:51:06 INFO - "slavename": "talos-linux64-ix-005", 17:51:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:51:06 INFO - "platform": "ubuntu64_hw", 17:51:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:51:06 INFO - "branch": "mozilla-aurora", 17:51:06 INFO - "repo_path": "releases/mozilla-aurora", 17:51:06 INFO - "revision": "116d83d90ce4ca5cb214e3e33c5da6735d59b848", 17:51:06 INFO - "stage_platform": "linux64-pgo", 17:51:06 INFO - "builduid": "63ab215d18974ae997fd70b326b24b52", 17:51:06 INFO - "slavebuilddir": "test" 17:51:06 INFO - } 17:51:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 17:51:06 INFO - Running post-action listener: _resource_record_post_action 17:51:06 INFO - [mozharness: 2016-11-24 01:51:06.849523Z] Finished read-buildbot-config step (success) 17:51:06 INFO - [mozharness: 2016-11-24 01:51:06.849611Z] Running download-and-extract step. 17:51:06 INFO - Running pre-action listener: _resource_record_pre_action 17:51:06 INFO - Running main action method: download_and_extract 17:51:06 INFO - mkdir: /builds/slave/test/build/tests 17:51:06 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')]} 17:51:06 INFO - trying https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:51:06 INFO - Downloading https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/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 17:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/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 17:51:07 INFO - Downloaded 1361 bytes. 17:51:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:51:07 INFO - Using the following test package requirements: 17:51:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:51:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:51:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:51:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'jsshell-linux-x86_64.zip'], 17:51:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:51:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:51:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:51:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:51:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:51:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:51:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:51:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:51:08 INFO - Http code: 200 17:51:08 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 17:51:08 INFO - x-amz-cf-id: 6SM-IsYQY2drHqiIAqviJWkOq1Vyqhrsm7_IXFNGqoCDkd2NGe76yg== 17:51:08 INFO - x-amz-version-id: VnMZugrGyKpaqGUGRPHMyyuMjOMZSVgd 17:51:08 INFO - Expected file size: 21950298 17:51:08 INFO - Obtained file size: 21950298 17:51:12 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 17:51:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:51:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:51:12 INFO - Fetch https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:51:12 INFO - Http code: 200 17:51:12 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 17:51:12 INFO - x-amz-cf-id: 9CwBs74WbpR2Hsq4RmmvmCvezhVvW3C2TvYjNAFaiXFNPDm78x8_xg== 17:51:12 INFO - x-amz-version-id: VnMZugrGyKpaqGUGRPHMyyuMjOMZSVgd 17:51:13 INFO - Expected file size: 21950298 17:51:13 INFO - Obtained file size: 21950298 17:51:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 17:51:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:51:17 INFO - Fetch https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 17:51:18 INFO - Http code: 200 17:51:18 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 17:51:18 INFO - x-amz-cf-id: NxqKdTJJPJUXEXEAdhmzrkyFY8fQa5Ni-NTI5s2kWLskRvlqUWqCrw== 17:51:18 INFO - x-amz-version-id: ZVhhEcn83y3zS5I4pZrNW_KJzT7i0uHU 17:51:18 INFO - Expected file size: 14409038 17:51:18 INFO - Obtained file size: 14409038 17:51:19 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')]} 17:51:19 INFO - trying https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:51:19 INFO - Downloading https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/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 17:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/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 17:51:22 INFO - Downloaded 63957751 bytes. 17:51:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:51:22 INFO - mkdir: /builds/slave/test/properties 17:51:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:51:22 INFO - Writing to file /builds/slave/test/properties/build_url 17:51:22 INFO - Contents: 17:51:22 INFO - build_url:https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:51:22 INFO - Running post-action listener: _resource_record_post_action 17:51:22 INFO - Running post-action listener: set_extra_try_arguments 17:51:22 INFO - [mozharness: 2016-11-24 01:51:22.668636Z] Finished download-and-extract step (success) 17:51:22 INFO - [mozharness: 2016-11-24 01:51:22.668863Z] Running populate-webroot step. 17:51:22 INFO - Running pre-action listener: _resource_record_pre_action 17:51:22 INFO - Running main action method: populate_webroot 17:51:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:51:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:51:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:51:22 INFO - '--tppagecycles', 17:51:22 INFO - '7'], 17:51:22 INFO - 'tests': ['tsvgm']}}, 17:51:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:51:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:51:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:51:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:51:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['damp', 'tps']}, 17:51:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'tests': ['damp', 'tps']}, 17:51:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['dromaeo_dom']}, 17:51:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:51:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['basic_compositor_video']}, 17:51:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:51:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'other-e10s': {'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['a11yr', 17:51:22 INFO - 'ts_paint', 17:51:22 INFO - 'tpaint', 17:51:22 INFO - 'sessionrestore', 17:51:22 INFO - 'sessionrestore_no_auto_restore', 17:51:22 INFO - 'tabpaint']}, 17:51:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['tsvgx', 17:51:22 INFO - 'tsvgr_opacity', 17:51:22 INFO - 'tart', 17:51:22 INFO - 'tscrollx', 17:51:22 INFO - 'cart']}, 17:51:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:51:22 INFO - 'tsvgr_opacity', 17:51:22 INFO - 'tart', 17:51:22 INFO - 'tscrollx', 17:51:22 INFO - 'cart']}, 17:51:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'talos_options': ['--disable-e10s'], 17:51:22 INFO - 'tests': ['tp5o']}, 17:51:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'tests': ['tp5o']}, 17:51:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'talos_options': ['--disable-e10s', 17:51:22 INFO - '--xperf_path', 17:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:22 INFO - 'tests': ['tp5n']}, 17:51:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:22 INFO - 'talos_options': ['--xperf_path', 17:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:22 INFO - 'tests': ['tp5n']}}, 17:51:22 INFO - 'talos.zip': {'path': '', 17:51:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:51:22 INFO - Running post-action listener: _resource_record_post_action 17:51:22 INFO - [mozharness: 2016-11-24 01:51:22.689349Z] Finished populate-webroot step (success) 17:51:22 INFO - [mozharness: 2016-11-24 01:51:22.689437Z] Running create-virtualenv step. 17:51:22 INFO - Running pre-action listener: _resource_record_pre_action 17:51:22 INFO - Running main action method: create_virtualenv 17:51:22 INFO - Creating virtualenv /builds/slave/test/build/venv 17:51:22 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 17:51:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:51:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:51:22 INFO - Using real prefix '/usr' 17:51:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:51:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:51:25 INFO - Installing pip.................done. 17:51:25 INFO - Return code: 0 17:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:51:25 INFO - Reading from file tmpfile_stdout 17:51:25 INFO - Output received: 17:51:25 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) 17:51:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:51:25 INFO - Using env: {'DISPLAY': ':0', 17:51:25 INFO - 'HOME': '/home/cltbld', 17:51:25 INFO - 'LANG': 'en_US.UTF-8', 17:51:25 INFO - 'LANGUAGE': 'en_US:en', 17:51:25 INFO - 'LOGNAME': 'cltbld', 17:51:25 INFO - 'MAIL': '/var/mail/cltbld', 17:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:25 INFO - 'MOZ_NO_REMOTE': '1', 17:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:25 INFO - 'NO_EM_RESTART': '1', 17:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:25 INFO - 'PWD': '/builds/slave/test', 17:51:25 INFO - 'SHELL': '/bin/bash', 17:51:25 INFO - 'SHLVL': '1', 17:51:25 INFO - 'TERM': 'linux', 17:51:25 INFO - 'TMOUT': '86400', 17:51:25 INFO - 'USER': 'cltbld', 17:51:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:25 INFO - '_': '/tools/buildbot/bin/python'} 17:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:25 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 17:51:25 INFO - Cleaning up... 17:51:25 INFO - Return code: 0 17:51:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:51:25 INFO - Using env: {'DISPLAY': ':0', 17:51:25 INFO - 'HOME': '/home/cltbld', 17:51:25 INFO - 'LANG': 'en_US.UTF-8', 17:51:25 INFO - 'LANGUAGE': 'en_US:en', 17:51:25 INFO - 'LOGNAME': 'cltbld', 17:51:25 INFO - 'MAIL': '/var/mail/cltbld', 17:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:25 INFO - 'MOZ_NO_REMOTE': '1', 17:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:25 INFO - 'NO_EM_RESTART': '1', 17:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:25 INFO - 'PWD': '/builds/slave/test', 17:51:25 INFO - 'SHELL': '/bin/bash', 17:51:25 INFO - 'SHLVL': '1', 17:51:25 INFO - 'TERM': 'linux', 17:51:25 INFO - 'TMOUT': '86400', 17:51:25 INFO - 'USER': 'cltbld', 17:51:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:25 INFO - '_': '/tools/buildbot/bin/python'} 17:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:25 INFO - Downloading/unpacking psutil>=3.1.1 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:27 INFO - Installing collected packages: psutil 17:51:27 INFO - Running setup.py install for psutil 17:51:28 INFO - building 'psutil._psutil_linux' extension 17:51:28 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 17:51:28 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 17:51:28 INFO - building 'psutil._psutil_posix' extension 17:51:28 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 17:51:28 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 17:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:28 INFO - Successfully installed psutil 17:51:28 INFO - Cleaning up... 17:51:28 INFO - Return code: 0 17:51:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:51:28 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')]} 17:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:28 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')]} 17:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:28 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:28 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 17:51:28 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 17:51:28 INFO - Using env: {'DISPLAY': ':0', 17:51:28 INFO - 'HOME': '/home/cltbld', 17:51:28 INFO - 'LANG': 'en_US.UTF-8', 17:51:28 INFO - 'LANGUAGE': 'en_US:en', 17:51:28 INFO - 'LOGNAME': 'cltbld', 17:51:28 INFO - 'MAIL': '/var/mail/cltbld', 17:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:28 INFO - 'MOZ_NO_REMOTE': '1', 17:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:28 INFO - 'NO_EM_RESTART': '1', 17:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:28 INFO - 'PWD': '/builds/slave/test', 17:51:28 INFO - 'SHELL': '/bin/bash', 17:51:28 INFO - 'SHLVL': '1', 17:51:28 INFO - 'TERM': 'linux', 17:51:28 INFO - 'TMOUT': '86400', 17:51:28 INFO - 'USER': 'cltbld', 17:51:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:28 INFO - '_': '/tools/buildbot/bin/python'} 17:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:51:30 INFO - Installing collected packages: mozsystemmonitor 17:51:30 INFO - Running setup.py install for mozsystemmonitor 17:51:30 INFO - Successfully installed mozsystemmonitor 17:51:30 INFO - Cleaning up... 17:51:30 INFO - Return code: 0 17:51:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:30 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:30 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 17:51:30 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 17:51:30 INFO - Using env: {'DISPLAY': ':0', 17:51:30 INFO - 'HOME': '/home/cltbld', 17:51:30 INFO - 'LANG': 'en_US.UTF-8', 17:51:30 INFO - 'LANGUAGE': 'en_US:en', 17:51:30 INFO - 'LOGNAME': 'cltbld', 17:51:30 INFO - 'MAIL': '/var/mail/cltbld', 17:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:30 INFO - 'MOZ_NO_REMOTE': '1', 17:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:30 INFO - 'NO_EM_RESTART': '1', 17:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:30 INFO - 'PWD': '/builds/slave/test', 17:51:30 INFO - 'SHELL': '/bin/bash', 17:51:30 INFO - 'SHLVL': '1', 17:51:30 INFO - 'TERM': 'linux', 17:51:30 INFO - 'TMOUT': '86400', 17:51:30 INFO - 'USER': 'cltbld', 17:51:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:30 INFO - '_': '/tools/buildbot/bin/python'} 17:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 17:51:31 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 17:51:31 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 17:51:31 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 17:51:31 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 17:51:31 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 17:51:31 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 17:51:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:33 INFO - warning: no files found matching '*.txt' 17:51:33 INFO - no previously-included directories found matching 'build' 17:51:33 INFO - no previously-included directories found matching 'dist' 17:51:33 INFO - no previously-included directories found matching '.git*' 17:51:33 INFO - Installing collected packages: jsonschema, functools32 17:51:33 INFO - Running setup.py install for functools32 17:51:33 INFO - warning: no files found matching '*.txt' 17:51:33 INFO - no previously-included directories found matching 'build' 17:51:33 INFO - no previously-included directories found matching 'dist' 17:51:33 INFO - no previously-included directories found matching '.git*' 17:51:33 INFO - Successfully installed jsonschema functools32 17:51:33 INFO - Cleaning up... 17:51:33 INFO - Return code: 0 17:51:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:33 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:33 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 17:51:33 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 17:51:33 INFO - Using env: {'DISPLAY': ':0', 17:51:33 INFO - 'HOME': '/home/cltbld', 17:51:33 INFO - 'LANG': 'en_US.UTF-8', 17:51:33 INFO - 'LANGUAGE': 'en_US:en', 17:51:33 INFO - 'LOGNAME': 'cltbld', 17:51:33 INFO - 'MAIL': '/var/mail/cltbld', 17:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:33 INFO - 'MOZ_NO_REMOTE': '1', 17:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:33 INFO - 'NO_EM_RESTART': '1', 17:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:33 INFO - 'PWD': '/builds/slave/test', 17:51:33 INFO - 'SHELL': '/bin/bash', 17:51:33 INFO - 'SHLVL': '1', 17:51:33 INFO - 'TERM': 'linux', 17:51:33 INFO - 'TMOUT': '86400', 17:51:33 INFO - 'USER': 'cltbld', 17:51:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:33 INFO - '_': '/tools/buildbot/bin/python'} 17:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:51:33 INFO - Cleaning up... 17:51:33 INFO - Return code: 0 17:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:33 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:33 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 17:51:33 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 17:51:33 INFO - Using env: {'DISPLAY': ':0', 17:51:33 INFO - 'HOME': '/home/cltbld', 17:51:33 INFO - 'LANG': 'en_US.UTF-8', 17:51:33 INFO - 'LANGUAGE': 'en_US:en', 17:51:33 INFO - 'LOGNAME': 'cltbld', 17:51:33 INFO - 'MAIL': '/var/mail/cltbld', 17:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:33 INFO - 'MOZ_NO_REMOTE': '1', 17:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:33 INFO - 'NO_EM_RESTART': '1', 17:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:33 INFO - 'PWD': '/builds/slave/test', 17:51:33 INFO - 'SHELL': '/bin/bash', 17:51:33 INFO - 'SHLVL': '1', 17:51:33 INFO - 'TERM': 'linux', 17:51:33 INFO - 'TMOUT': '86400', 17:51:33 INFO - 'USER': 'cltbld', 17:51:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:33 INFO - '_': '/tools/buildbot/bin/python'} 17:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:33 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 17:51:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51:36 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 17:51:36 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 17:51:36 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 17:51:36 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 17:51:36 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 17:51:36 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 17:51:36 INFO - Downloading docopt-0.6.1.tar.gz 17:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:36 INFO - Running setup.py install for blobuploader 17:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:36 INFO - Running setup.py install for requests 17:51:37 INFO - Running setup.py install for docopt 17:51:37 INFO - Successfully installed blobuploader requests docopt 17:51:37 INFO - Cleaning up... 17:51:37 INFO - Return code: 0 17:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:37 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:37 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 17:51:37 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 17:51:37 INFO - Using env: {'DISPLAY': ':0', 17:51:37 INFO - 'HOME': '/home/cltbld', 17:51:37 INFO - 'LANG': 'en_US.UTF-8', 17:51:37 INFO - 'LANGUAGE': 'en_US:en', 17:51:37 INFO - 'LOGNAME': 'cltbld', 17:51:37 INFO - 'MAIL': '/var/mail/cltbld', 17:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:37 INFO - 'MOZ_NO_REMOTE': '1', 17:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:37 INFO - 'NO_EM_RESTART': '1', 17:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:37 INFO - 'PWD': '/builds/slave/test', 17:51:37 INFO - 'SHELL': '/bin/bash', 17:51:37 INFO - 'SHLVL': '1', 17:51:37 INFO - 'TERM': 'linux', 17:51:37 INFO - 'TMOUT': '86400', 17:51:37 INFO - 'USER': 'cltbld', 17:51:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:37 INFO - '_': '/tools/buildbot/bin/python'} 17:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:37 INFO - Running setup.py (path:/tmp/pip-ffLUZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:37 INFO - Running setup.py (path:/tmp/pip-9xAS0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:37 INFO - Running setup.py (path:/tmp/pip-uLqzcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:37 INFO - Running setup.py (path:/tmp/pip-TlOFjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:37 INFO - Running setup.py (path:/tmp/pip-XPlZse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:37 INFO - Running setup.py (path:/tmp/pip-rCqscJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:37 INFO - Running setup.py (path:/tmp/pip-oP5ELM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:37 INFO - Running setup.py (path:/tmp/pip-X2atba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:38 INFO - Running setup.py (path:/tmp/pip-MY6H5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:38 INFO - Running setup.py (path:/tmp/pip-iZCai_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:38 INFO - Running setup.py (path:/tmp/pip-ljtC7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:38 INFO - Running setup.py (path:/tmp/pip-kwKS7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:38 INFO - Running setup.py (path:/tmp/pip-hHi8Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:38 INFO - Running setup.py (path:/tmp/pip-9zNvmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:38 INFO - Running setup.py (path:/tmp/pip-7k0caZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:38 INFO - Running setup.py (path:/tmp/pip-ofjrjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:38 INFO - Running setup.py (path:/tmp/pip-xdagP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:38 INFO - Running setup.py install for manifestparser 17:51:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:38 INFO - Running setup.py install for mozcrash 17:51:38 INFO - Running setup.py install for mozdebug 17:51:38 INFO - Running setup.py install for mozdevice 17:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for mozfile 17:51:39 INFO - Running setup.py install for mozhttpd 17:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for mozinfo 17:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for mozInstall 17:51:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for mozleak 17:51:39 INFO - Running setup.py install for mozlog 17:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for moznetwork 17:51:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:39 INFO - Running setup.py install for mozprocess 17:51:39 INFO - Running setup.py install for mozprofile 17:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:40 INFO - Running setup.py install for mozrunner 17:51:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:40 INFO - Running setup.py install for mozscreenshot 17:51:40 INFO - Running setup.py install for moztest 17:51:40 INFO - Running setup.py install for mozversion 17:51:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:40 INFO - Cleaning up... 17:51:40 INFO - Return code: 0 17:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:40 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:40 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 17:51:40 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 17:51:40 INFO - Using env: {'DISPLAY': ':0', 17:51:40 INFO - 'HOME': '/home/cltbld', 17:51:40 INFO - 'LANG': 'en_US.UTF-8', 17:51:40 INFO - 'LANGUAGE': 'en_US:en', 17:51:40 INFO - 'LOGNAME': 'cltbld', 17:51:40 INFO - 'MAIL': '/var/mail/cltbld', 17:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:40 INFO - 'MOZ_NO_REMOTE': '1', 17:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:40 INFO - 'NO_EM_RESTART': '1', 17:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:40 INFO - 'PWD': '/builds/slave/test', 17:51:40 INFO - 'SHELL': '/bin/bash', 17:51:40 INFO - 'SHLVL': '1', 17:51:40 INFO - 'TERM': 'linux', 17:51:40 INFO - 'TMOUT': '86400', 17:51:40 INFO - 'USER': 'cltbld', 17:51:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:40 INFO - '_': '/tools/buildbot/bin/python'} 17:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:40 INFO - Running setup.py (path:/tmp/pip-yeyCDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:40 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)) 17:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:40 INFO - Running setup.py (path:/tmp/pip-NZJKip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:40 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)) 17:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:40 INFO - Running setup.py (path:/tmp/pip-7xfFWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:40 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)) 17:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:40 INFO - Running setup.py (path:/tmp/pip-GzPjtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:41 INFO - Running setup.py (path:/tmp/pip-qoPkxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:41 INFO - Running setup.py (path:/tmp/pip-7GOtx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:41 INFO - Running setup.py (path:/tmp/pip-SwSdQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:41 INFO - Running setup.py (path:/tmp/pip-XxdQ8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:41 INFO - Running setup.py (path:/tmp/pip-kIT3re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:41 INFO - Running setup.py (path:/tmp/pip-80asf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:41 INFO - Running setup.py (path:/tmp/pip-dgyXvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:41 INFO - Running setup.py (path:/tmp/pip-qoqbuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:41 INFO - Running setup.py (path:/tmp/pip-_QVJsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:41 INFO - Running setup.py (path:/tmp/pip-DMMYPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:41 INFO - Running setup.py (path:/tmp/pip-kAYMbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:41 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)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:41 INFO - Running setup.py (path:/tmp/pip-8QIMUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:41 INFO - Running setup.py (path:/tmp/pip-4pLnX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:41 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)) 17:51:41 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)) 17:51:41 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)) 17:51:41 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)) 17:51:41 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)) 17:51:41 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)) 17:51:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:41 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 17:51:41 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 17:51:41 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 17:51:41 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 17:51:41 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 17:51:41 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 17:51:43 INFO - Downloading blessings-1.6.tar.gz 17:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:44 INFO - Installing collected packages: blessings 17:51:44 INFO - Running setup.py install for blessings 17:51:44 INFO - Successfully installed blessings 17:51:44 INFO - Cleaning up... 17:51:44 INFO - Return code: 0 17:51:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:44 INFO - Reading from file tmpfile_stdout 17:51:44 INFO - Current package versions: 17:51:44 INFO - argparse == 1.2.1 17:51:44 INFO - blessings == 1.6 17:51:44 INFO - blobuploader == 1.2.4 17:51:44 INFO - docopt == 0.6.1 17:51:44 INFO - functools32 == 3.2.3-2 17:51:44 INFO - jsonschema == 2.5.1 17:51:44 INFO - manifestparser == 1.1 17:51:44 INFO - mozInstall == 1.12 17:51:44 INFO - mozcrash == 1.0 17:51:44 INFO - mozdebug == 0.1 17:51:44 INFO - mozdevice == 0.48 17:51:44 INFO - mozfile == 1.2 17:51:44 INFO - mozhttpd == 0.7 17:51:44 INFO - mozinfo == 0.9 17:51:44 INFO - mozleak == 0.1 17:51:44 INFO - mozlog == 3.4 17:51:44 INFO - moznetwork == 0.27 17:51:44 INFO - mozprocess == 0.23 17:51:44 INFO - mozprofile == 0.28 17:51:44 INFO - mozrunner == 6.13 17:51:44 INFO - mozscreenshot == 0.1 17:51:44 INFO - mozsystemmonitor == 0.3 17:51:44 INFO - moztest == 0.7 17:51:44 INFO - mozversion == 1.4 17:51:44 INFO - psutil == 3.1.1 17:51:44 INFO - requests == 1.2.3 17:51:44 INFO - wsgiref == 0.1.2 17:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:44 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')]} 17:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:44 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')]} 17:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:44 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:44 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 17:51:44 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 17:51:44 INFO - Using env: {'DISPLAY': ':0', 17:51:44 INFO - 'HOME': '/home/cltbld', 17:51:44 INFO - 'LANG': 'en_US.UTF-8', 17:51:44 INFO - 'LANGUAGE': 'en_US:en', 17:51:44 INFO - 'LOGNAME': 'cltbld', 17:51:44 INFO - 'MAIL': '/var/mail/cltbld', 17:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:44 INFO - 'MOZ_NO_REMOTE': '1', 17:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:44 INFO - 'NO_EM_RESTART': '1', 17:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:44 INFO - 'PWD': '/builds/slave/test', 17:51:44 INFO - 'SHELL': '/bin/bash', 17:51:44 INFO - 'SHLVL': '1', 17:51:44 INFO - 'TERM': 'linux', 17:51:44 INFO - 'TMOUT': '86400', 17:51:44 INFO - 'USER': 'cltbld', 17:51:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:44 INFO - '_': '/tools/buildbot/bin/python'} 17:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 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)) 17:51:44 INFO - Cleaning up... 17:51:44 INFO - Return code: 0 17:51:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:44 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')]} 17:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:44 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')]} 17:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:44 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 0x7f1883460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b82ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', '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 17:51:44 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 17:51:44 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 17:51:44 INFO - Using env: {'DISPLAY': ':0', 17:51:44 INFO - 'HOME': '/home/cltbld', 17:51:44 INFO - 'LANG': 'en_US.UTF-8', 17:51:44 INFO - 'LANGUAGE': 'en_US:en', 17:51:44 INFO - 'LOGNAME': 'cltbld', 17:51:44 INFO - 'MAIL': '/var/mail/cltbld', 17:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:44 INFO - 'MOZ_NO_REMOTE': '1', 17:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:44 INFO - 'NO_EM_RESTART': '1', 17:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:44 INFO - 'PWD': '/builds/slave/test', 17:51:44 INFO - 'SHELL': '/bin/bash', 17:51:44 INFO - 'SHLVL': '1', 17:51:44 INFO - 'TERM': 'linux', 17:51:44 INFO - 'TMOUT': '86400', 17:51:44 INFO - 'USER': 'cltbld', 17:51:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:44 INFO - '_': '/tools/buildbot/bin/python'} 17:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:51:44 INFO - Cleaning up... 17:51:44 INFO - Return code: 0 17:51:44 INFO - Running post-action listener: _resource_record_post_action 17:51:44 INFO - Running post-action listener: _start_resource_monitoring 17:51:44 INFO - Starting resource monitoring. 17:51:44 INFO - [mozharness: 2016-11-24 01:51:44.908307Z] Finished create-virtualenv step (success) 17:51:44 INFO - [mozharness: 2016-11-24 01:51:44.908817Z] Running install step. 17:51:44 INFO - Running pre-action listener: _resource_record_pre_action 17:51:44 INFO - Running main action method: install 17:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:45 INFO - Reading from file tmpfile_stdout 17:51:45 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:45 INFO - Reading from file tmpfile_stdout 17:51:45 INFO - Output received: 17:51:45 INFO - Usage: mozinstall [options] installer 17:51:45 INFO - Options: 17:51:45 INFO - -h, --help show this help message and exit 17:51:45 INFO - -d DEST, --destination=DEST 17:51:45 INFO - Directory to install application into. [default: 17:51:45 INFO - "/builds/slave/test"] 17:51:45 INFO - --app=APP Application being installed. [default: firefox] 17:51:45 INFO - mkdir: /builds/slave/test/build/application 17:51:45 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'] 17:51:45 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 17:52:01 INFO - Reading from file tmpfile_stdout 17:52:01 INFO - Output received: 17:52:01 INFO - /builds/slave/test/build/application/firefox/firefox 17:52:01 INFO - Running post-action listener: _resource_record_post_action 17:52:01 INFO - [mozharness: 2016-11-24 01:52:01.102502Z] Finished install step (success) 17:52:01 INFO - [mozharness: 2016-11-24 01:52:01.102746Z] Running run-tests step. 17:52:01 INFO - Running pre-action listener: _resource_record_pre_action 17:52:01 INFO - Running main action method: run_tests 17:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:52:01 INFO - Python 2.7.3 17:52:01 INFO - Return code: 0 17:52:01 INFO - grabbing minidump binary from tooltool 17:52: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')]} 17:52:01 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 0x1b7ff60>, '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 0x1b80d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b811d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:52:01 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 17:52:01 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 17:52:01 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 17:52:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:52:01 INFO - Return code: 0 17:52:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:52:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:52:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:52:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:52:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:52:01 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/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:52:01 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/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 17:52:01 INFO - Using env: {'DISPLAY': ':0', 17:52:01 INFO - 'HOME': '/home/cltbld', 17:52:01 INFO - 'LANG': 'en_US.UTF-8', 17:52:01 INFO - 'LANGUAGE': 'en_US:en', 17:52:01 INFO - 'LOGNAME': 'cltbld', 17:52:01 INFO - 'MAIL': '/var/mail/cltbld', 17:52:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:52:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:01 INFO - 'MOZ_NO_REMOTE': '1', 17:52:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:01 INFO - 'NO_EM_RESTART': '1', 17:52:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:01 INFO - 'PWD': '/builds/slave/test', 17:52:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:52:01 INFO - 'SHELL': '/bin/bash', 17:52:01 INFO - 'SHLVL': '1', 17:52:01 INFO - 'TERM': 'linux', 17:52:01 INFO - 'TMOUT': '86400', 17:52:01 INFO - 'USER': 'cltbld', 17:52:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140', 17:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:01 INFO - '_': '/tools/buildbot/bin/python'} 17:52:01 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/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:52:01 INFO - mozversion application_buildid: 20161123150736 17:52:01 INFO - mozversion application_changeset: 116d83d90ce4ca5cb214e3e33c5da6735d59b848 17:52:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:52:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:52:01 INFO - mozversion application_name: Firefox 17:52:01 INFO - mozversion application_remotingname: firefox-dev 17:52:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:52:01 INFO - mozversion application_vendor: Mozilla 17:52:01 INFO - mozversion application_version: 52.0a2 17:52:01 INFO - mozversion platform_buildid: 20161123150736 17:52:01 INFO - mozversion platform_changeset: 116d83d90ce4ca5cb214e3e33c5da6735d59b848 17:52:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:52:01 INFO - mozversion platform_version: 52.0a2 17:52:01 INFO - using testdate: 1479952321 17:52:01 INFO - actual date: 1479952321 17:52:01 INFO - starting webserver on 'localhost:40510' 17:52:01 INFO - SUITE-START | Running 2 tests 17:52:01 INFO - TEST-START | dromaeo_css 17:52:01 INFO - operating with platform_type : linux_ 17:52:01 INFO - Initialising browser for dromaeo_css test... 17:52:01 INFO - TEST-INFO | started process 9652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptH0fPT/profile http://localhost:40510/getInfo.html) 17:52:04 ERROR - PROCESS | 9652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 17:52:05 INFO - PROCESS | 9652 | __metrics Screen width/height:1600/1200 17:52:05 INFO - PROCESS | 9652 | colorDepth:24 17:52:05 INFO - PROCESS | 9652 | Browser inner width/height: 1024/697 17:52:05 INFO - PROCESS | 9652 | __metrics 17:52:05 INFO - PROCESS | 9652 | 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" 17:52:05 INFO - PROCESS | 9652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:52:06 INFO - PROCESS | 9652 | console.error: PushService: 17:52:06 INFO - PROCESS | 9652 | stateChangeProcessEnqueue: Error transitioning state 17:52:06 INFO - PROCESS | 9652 | UnknownError 17:52:06 INFO - TEST-INFO | 9652: exit 0 17:52:06 INFO - Browser initialized. 17:52:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:52:06 INFO - TEST-INFO | started process 9746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptH0fPT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:18 INFO - PROCESS | 9746 | RSS: Main: 144728064 17:52:18 INFO - PROCESS | 9746 | 17:53:10 INFO - PROCESS | 9746 | 1479952390266 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:55:19 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40510/tests/dromaeo/cssquery-ext.html) 17:55:21 INFO - PROCESS | 9746 | RSS: Main: 252383232 17:55:21 INFO - PROCESS | 9746 | 17:58:23 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-ext.html (next: http://localhost:40510/tests/dromaeo/cssquery-jquery.html) 17:58:24 INFO - PROCESS | 9746 | RSS: Main: 235270144 17:58:24 INFO - PROCESS | 9746 | 18:01:26 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40510/tests/dromaeo/cssquery-mootools.html) 18:01:26 INFO - PROCESS | 9746 | RSS: Main: 175284224 18:01:26 INFO - PROCESS | 9746 | 18:04:28 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40510/tests/dromaeo/cssquery-prototype.html) 18:04:29 INFO - PROCESS | 9746 | RSS: Main: 175382528 18:04:29 INFO - PROCESS | 9746 | 18:07:32 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40510/tests/dromaeo/cssquery-yui.html) 18:07:32 INFO - PROCESS | 9746 | RSS: Main: 176345088 18:07:32 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | Cycle 1(1): loaded http://localhost:40510/tests/dromaeo/cssquery-yui.html (next: http://localhost:40510/tests/dromaeo/cssquery-dojo.html) 18:10:35 INFO - PROCESS | 9746 | RSS: Main: 266575872 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | __start_tp_report 18:10:35 INFO - PROCESS | 9746 | _x_x_mozilla_page_load 18:10:35 INFO - PROCESS | 9746 | _x_x_mozilla_page_load_details 18:10:35 INFO - PROCESS | 9746 | |i|pagename|runs| 18:10:35 INFO - PROCESS | 9746 | |0;dojo.html;3142.0573827851645;3187.2509960159346;3192.9942068248506;3210.8876189333378;3213.66256543063;5387.272718183049;5509.724513774316;5515.944840551593;5519.282493275873;5535.446455354462;5451.291332126828;5480.725963701819;5493.890122197554;5497.285352904127;5528.806491772789;4957.727324997124;4975.079610272093;5017.422996355429;5032.874178145557;5039.168537191359;4775.952240477585;4795.160846851804;4969.925451118236;5025.020121076392;5052.242163675442;4870.634702397317;4907.2639104134305;4914.287428322891;4940.25896115582;4981;4986.626003049768;5011.398632164145;5058.2412638104215;5061.797528098871;5092.134337162654;4705.6470764692785;4982.227754698028;5000.42495113063;5011.3485246918035;5043.092243396187;5166.07010738067;5291.947080529184;5325.121354976424;5326.227696983954;5361.142217245222;5701.914471282934;5709.942900570983;5789.710514474302;5815.592908496407;5819.7672093116225;5672;5831.825045248649;5846.239988801429;5860.560457965627;5863.061910094407;5364.731763411853;5368.677879327252;5394.838154855361;5397.055515284809;5452.263944367499;5855.092460668603;5886.499647529922;5889.087191485327;5891.351951285355;5891.351951285355;5671.886562268732;5675.829725108253;5679.091345384802;5689.260396148474;5694.800681976194;5532.889342213133;5596.524295434852;5701;5766.625169363978;5769.1923130761725;5795.1017592273265;5795.275590551181;5795.275590551181;5803.47768700819;5823.155642431823;5743.2246646703;5794.275715535558;5797.971010144923;5807.361190269067;5822.155787410802;4396.736195828261;4427.490838553543;4461.977690111528;4476.328550717419;4531.3882625845745;4005.319095753729;4038.5355684096116;4050.311447054008;4060.0864805419137;4071.857484988011;5507.421720719347;5512.118061110203;5515.944840551623;5517.282753242052;5518.91721624176;5668.489835914705;5730.054541000688;5731.197632331477;5810;5828.708564571754;5444.3194600674915;5484.972575137099;5498.45015498447;5498.752556134984;5499.120140777456;5022.397312322545;5030.673006254582;5032.72320022395;5033.521815427602;5033.672811267256;5899.380565040695;5903.468687818117;5914.26071741041;5963.880722385528;5980.73086711099;5845.707714614337;5848.444397782204;5855.765769369177;5863.648181109147;5873.500752436091;6011.128386384037;6021.969890150521;6023.728932198149;6027.547933904887;6027.547933904887;5536;5583.776648934159;5595.664260144405;5746.597738158456;5753.683547404933;5740.770369185186;5797.304323481209;5812.360640329645;5829.562782791223;5844.736986835687;5647.830565083054;5658.349289831722;5658.603897727119;5662.915056274077;5666.575006874584;5453.209284653783;5520.779168833202;5644.040513112863;5661.547076233974;5662.57530685192;5566.554675625859;5584.329880414376;5600.299962504687;5645.548356131418;5673.3759286477625;5682.261306030189;5706.743196556248;5715.057015592547;5716.571257155647;5725.026745453366;5443.591730620298;5577.44225577439;5583.664980101207;5583.776648933997;5588.385277619377 18:10:35 INFO - PROCESS | 9746 | |1;ext.html;574.9593236242401;610.9572329936904;640.0878747784406;646.3213625693021;660.3363619562339;35861.28277434453;45250.773746131264;46517.534824651746;46557.30164047542;48874.26688599674;47128.29307560389;47669;47739.761301193445;47740.28389574151;47777.28334074992;8274;8726.95636521818;8872.20150186483;8880;8882.422642528216;8258.752237432856;10348.534315955763;10613.150947924187;10621.681349559487;10867.728306792314;10692;10746.140308775319;10750.838737418944;10751.51618177184;10753.354798712064;10635.57457701691;10710.089642380408;10713.83929241062;10729.83905241422;10734.355938643628;10460.163186945027;10516.474176291154;10519.579216831318;10526.10528105112;10531.84202236967;43623;44035.33946990798;44048.55951440477;44068;44172.337414938804;3887.086534664352;3902.6292502212245;3961.2869683456966;3994.8801535953967;4004.5795191504762;33078.50382244268;33390.165245869044;33405.498917516255;33610.49584256214;33724.83137584321;4540.7502587357685;4615.26155815068;4630.699004564726;4646.605038571725;4672.345871577982;367319;367395;367862;368030;368217;63954.6802265995;64169.679151603945;64226;64476.03285950715;64556;39239.60760392417;40412.59587404088;40696;42447;42500.57499424966;17098.743518847226;17160.742588861176;17244.396446124578;17251.913740431217;17263.05053222085;11684.065274777997;11744.060475161967;12747.617571472685;13292.136011159244;13456.529021484397;19536.76232267061;20392.592148156953;20417.183312667326;20521.179152834018;20662.896685516476;7333.963330183422;7359.227281135511;7511.399088072941;7704.152543220242;7735.651895664709;970.9077637624414;1000.309786247487;1031;1075.6611667324767;1084.810158222308;33739.29904697141;34311.82844085814;34367.656323436946;34464.310713786086;34506;1163.2555164694602;1175.9294442333487;1192.0165863162924;1220.700928272579;1281.4489769399247;17850.386760030535;17859.46421607354;17895.73156402655;17958.304164122244;18020.729689054675;663584;679346;679890;829644;831382;61903.6904815473;62848.37151628425;63050.68474657597;63164.68417657882;63166.68416657979;1316.8748968847945;1384.9653758655913;1396.4902810474105;1413.4699487692114;1448.5147475595584;31305.217369565944;34668.82665586656;35063.12342191364;35065.29869402649;35071;53555;54208.99999999842;54271.45728542664;54324;54355;447783;450706;452950;454068;455148;27623.30941726473;27733.722662773922;27980;28090.157295281173;30925.072247832602;43698.34452483279;48718.5128148714;48729.5127048725;48973;49059.264111039076;40734.30296187434;43099.784501077294;43109.78445107755;43302.350464743686;43707;36532.63467365292;37138.25723485461;37665.62334376621;38177;38440;41542.58457415387;41798.373024405264;42554.78722606367;42837.14325713531;42884.571154289304;34438.827805861816;37217.81391093027;37474;37902;38769.224615506966;28237.57643635306;28239.435211295247;28525.572116417854;28547;28615.856920716094 18:10:35 INFO - PROCESS | 9746 | |2;jquery.html;390.5001597954619;405.84780707234785;413.5285774217392;419.3186072631973;420.68658849157384;14320.641983950407;16445;19164.233430662756;19563.608727825434;19786.208551657917;19784.802151978474;20088.69866951997;20268.391948241577;20330.69503957438;20427.591448171028;5631.465010823965;5640.887182256352;5754.165645981351;5800.941990580082;5872.442117998783;4212.283911735012;4406.030673251879;5705.74324155414;5798.275215598051;5802.82591522255;6112.908306375408;6402.6158430494315;6408.038794180864;6541.574797638162;6546.672666366662;6260.405261500173;6355.9364406356035;6395.488360931115;6399.36006399361;6511.055896894971;5632.436756324335;5634.098544232944;5640.915386269209;5641.182028605829;5644.802431914904;21846.672299915514;22529.436764080867;22717.091316347327;23592.528149437087;23846.642300365507;2352.447174913911;2561.103613735178;2599;2896.985515072432;2902.85485725715;10309.948450257702;10454.738631534197;10848.02367786895;10858.34849909008;10933.781324373547;1896.3268039845793;1997.4107638246608;2002.979970200294;2004.1983206717284;2069.1102825784906;83484;86112.13887861103;87342;88355.55822220912;88672;11420.657380278604;11547.595834145764;11578.594749183738;11613.535458581562;11849.229800062969;16348.264328105264;16348.673026539402;16368.918155409385;16371.672566548603;16384;8601.612927418157;8729.825403491895;8738.519381434082;8774.166454186841;8803.691870784492;8412.200840920103;8430.32557395407;8486.787830304293;8689.13108689126;8711.869321960176;4946.233333833262;4966.925496117561;4970.229614409773;4999.875003124951;5060.696358218519;1983.6826107822967;2066.163203902422;2067.958640827175;2090.2997495839063;2101.327575175929;938.2025278513346;959.1176117971344;964.4984608003799;1001.1890368801148;1043.2540733375522;19957.401277961686;20104.793712377304;20192.39422817318;20384.592308153755;20484;993.7316924430363;1014.8426993815971;1027.5786927359895;1039.2569312941284;1073.3345325897992;10475.47622618866;10613.787724245472;11196;11337.773244535063;11386.943065284786;511779;519131;523961;528388;540228;61401.38598613957;70176.6491167541;88714;89276.5536172315;89517.55241223752;980.4362491567234;1026.4046852825343;1064.8881867403966;1092.4646923007829;1114.6321713834416;17373;17518.91240543789;17644.470665880042;17720.64558708793;18074.548136296697;44455.33317000312;44537.10508816916;44686.77656611696;45549.77225113986;46519.302210466194;61980.380196199265;63087.6845615769;63137.684311578145;63490.68254658697;66497.33502664912;8415.032271288881;8479.869678844458;8524.488530688179;8809.735707928772;9054.230390416888;11628.244164129304;13309.267990260241;13437.798433023318;13505.932470337586;13581;11497.885021149681;11512.654620361403;11547;11763.941180294043;11794.410279485819;11408.258463199865;11712.355820429617;11832.408379580815;12001.519939202333;12366.62900112998;11288.903991844312;11866.584669536525;11891.227070240408;12224.449899754354;12690.302033388252;8570.600521671307;8827.779305517413;8862.778430539289;9214.953925230599;9394.295427842802;11241.943790280997;11724.941375293069;11849.229800062969;12093.81859272094;12365 18:10:35 INFO - PROCESS | 9746 | |3;mootools.html;1505.0894209003552;1534.9539513814586;1650.8514233718963;1789.0071010589127;1790.1586254460415;8071.91928080719;8575.356848236375;8587.012493563234;8587.441816281953;8600.784980375494;7297.927020729791;7491.850162996737;7495.025646665939;7674.884876726854;8479.06730259671;2156.5147841735643;2397.3167647220544;2470.9011639534397;2474.4679893822827;2502.1492692484553;2453.313072339739;2484.291976786616;2487.166799122296;2491.489244704831;2495.02693949359;2392.605220138675;2417.093589903786;2418.7097548294228;2421.721502027263;2421.721502027272;2379.5478859016816;2424.309071914505;2442.1452491627965;2446.1805295226122;2448.2655203438985;2417.3473162246096;2428.672129262545;2444.4866578018637;2450.987745061281;2451.36264571211;8349.582520873932;8428.45215061019;8433.662653493853;8441.198086181865;8569;5268.209768534713;5407.324084489439;5416.945830541684;5418.078926582491;5425.213344065128;3334.149791803099;3459.705924996378;3461.44616861301;3465.128830431564;3493.0917961330238;1078.8273876179774;1125.482278152051;1158.7624536969902;1165.702745799824;1195.4261954262004;11669.241499302518;11763;11767.352795596238;11795.764084718343;11796.35120068396;4826;4968.850934471971;4996.5003499650475;5107.770150343244;5122.590192784568;9352.859707104399;9373.953130234306;9405.43567385959;9432.764180895532;9436.433813971184;5450.672959622435;5450.700211488406;5452.345718513724;5452.454754524595;5455.945440545624;4922.50774922512;5030.496950304941;5035.420926593415;5074.797008119708;5085.389753229636;3579.6241394653707;3721.2371463849845;3825.904352391157;3954.7429417088374;3970.06703424695;1168.9590864319878;1181.8640856301463;1206.77071356442;1211.6425654431964;1219.5975328141692;896.2337201692459;982.749398903275;1014.6702321745462;1037.1858091398367;1044.0394836750208;5811.970940145272;5890.587658863924;5944.5838791284195;6154.599951003171;6173.876522469525;994.2692121290845;1002.4386343647581;1009.615622786204;1019.6176433837311;1023.9436830974219;4217.283061879488;4261.232978063978;4309.956900431018;4313.805878735465;4464.866054018385;10115.898841011496;10330.741731456774;10343.586256549654;10419.635312764169;10440.843387349196;10254.692359229235;10256.12822910061;10269;10287.639932602324;10295.3822770634;7663.386929045663;7950.324222441157;7981.201879812089;7987.321077708344;8109.351251899834;6002.669853158118;6093.847653808691;6109.7861574844665;6146.938530614815;6239.344868788893;9651.855222171533;9660.468674222986;9665.565049572646;9679.370840895319;9689.370190937567;9638.9036109638;9932.900670993198;10028.69913902584;10044.096031357212;10044.748881277734;7667.271609197117;7779.260970207822;7793.532388056508;7798;7801.29788319054;7061.364477197077;7204.171520275026;8042.517448953082;8100.87848682282;8167.264946154874;7239.927600723925;7273.599952002691;7451.254874512505;7466.589337586485;7479.252074792477;7336;7352.4485663576515;7372.373348265458;7391;7452;6864.24493305746;6903.965480172567;6947.861042779217;7019.3682568569075;7021.087258656342;5161.690298582097;5256.264123022704;5262.921056184084;5375.731213439234;5470.753816078366;5304.549113325256;5389.083855744611;5421.1055175895535;5441.755121019484;5533.059379905345 18:10:35 INFO - PROCESS | 9746 | |4;prototype.html;349.5944704143193;351.26234906695936;356.839422259983;360.6898067661812;362.5848403577903;5414.62097653164;5419.485148910857;5424.701641409721;5437.6465529740535;5459.344878614572;5322.920156197651;5337.492938170868;5355.3305836770405;5401.918971215435;5405.18922161675;4009.6591789697763;4160.7087503874745;4193.979030104845;4197;4280.208161490119;4139.606737359946;4143.917121657565;4151.979240103795;4196.286631272676;4218.683598730092;3967.305721498726;4157.708960372775;4160.750354978696;4168.270552653289;4169.187008533338;4070.653994410464;4078.6125318094732;4155.812988415529;4179.72205148195;4194.769287689176;3695;3706.684931780802;3720.2559488102215;3726.2547490502006;3733.4213196954242;4966.304717339575;5163.122269214243;5188.247704082887;5264.578833693296;5283.128283833163;4609.700369476007;4759.286107083931;4760.404949381327;4790.736509491977;4801.879953001168;5534.640248383883;5595.272614560122;5605.747741351649;5614.157876318544;5639.577031722637;3965.920681586381;4054.614811592894;4095.836166553364;4101.323281658522;4103.610157035077;5774.335951365605;5784.942150578482;5795.275590551223;5798.159266906275;5806.5645076619;4120.423140760236;4125.91748165035;4126.793660316972;4144.5026596808575;4159.627322983408;4022.3765316376007;4202.411662367271;4217.261979153636;4226.5773422657485;4242.957570424318;4771.163102205675;4784.134187666813;4791.353167322437;4811.254255590389;4835.588974937099;5650.237217975603;5655.604107712503;5674;5678.858028549237;5692.829215123553;1339.4039652354804;1390.8872901678617;1409.7462456757678;1422.3670466642452;1427.4290283886528;953.9952300238455;955.1403736637083;967.2407160379069;981.1562056631434;991.2516050381915;5140.640155189101;5182.445266420134;5188.7405629719115;5219.1388420910125;5222.399424066281;5434.972825135849;5438.428964958702;5451.465068743054;5462.399136095027;5476.397596264408;5190.11767999441;5241.528262456397;5307.2569840222395;5323.1749078892835;5386;2905.288204389938;2905.3027273454218;2906.9273268168463;2916.672913824205;2921.8977335793147;5654.293213348332;5657.434256574392;5658.207850900877;5686.886262274731;5713.457221563945;5853.151293062482;5857.297124345106;5883.823485295448;5902.380250073767;5902.616329938626;5936.257967754031;5948.167256584082;5952.85117872048;6010.939890601126;6021.458068773832;5562.332520097614;5739.62692424991;5771.509421699203;5777.595568310178;5781.364049954585;5675.914861277001;5687.374388817309;5694.829155125353;5696.316442026983;5696.430356964271;5680.7443665036;5926.348101708722;5928.851778705567;5982.551308651781;6021.879562408815;4093.3450647896193;4138;4174.666026717795;4186.790660467025;4209.557996410455;5749.453801888814;5809.1949772898815;5817.563682723728;5837.708114594338;5849.151872978479;5404.297441332602;5563.693996830051;5699.8860022800145;5703.230063941315;5724.255846740064;5576.856744367314;5602.579806514446;5602.663840169603;5615.354234263112;5617.691026993554;5546.36216835053;5566.276384070045;5580.497755202051;5593.748281327269;5600.27196464457;5414.539764119936;5645.350784659652;5660.349059858169;5681.801136960186;5686.573506987075;5562.694051827189;5564.415736347625;5564.495976810533;5564.527015203591;5592.161175823497 18:10:35 INFO - PROCESS | 9746 | |5;yui.html;790.40324554961;812.2162113560416;840.2521755637483;854.9871751923722;870.4646642314979;14033.50882719105;15867.285972131267;16075.678486430264;16077.758833617476;16201.351945922164;14719.852801471981;14894.47869324574;14989.47536836211;15151.242437878118;15340.69318613627;724.149124778386;838.7609531283586;858.845407826591;858.8840506531632;858.9141085891423;740.3041141327162;836.2264904962915;859.3383095016833;863.3438586674141;864.9956750216271;901.2519608724742;902.2871931174398;903.8779764731776;904.4482865452102;904.6426661468716;743;898.9640414383417;901.7384958362068;902.8826252587187;903.2051794420901;560.0563051258642;634.7714822663837;656.2256537286;659.116783510094;660.0594153331531;14250.2162381069;14260.643483912881;14273.57179284623;14279.500217492337;14309.856901430956;13900.235487048209;14170.787438188436;14173.14961102327;14193.503227387095;14245.145291282453;12157.51369945201;12176.695582610506;12179;12381.75236495265;12434;4082.9795851020854;4083.8570650027104;4094.28350038745;4101.092068474033;4145.2952997990415;65974.34025659777;67669.32330676679;67677;68504.65747671279;69617.65191174012;10060.597576096874;10148.289619726549;10323.32898361604;10449.268551201494;10529;16047.839521604634;16108.838911610734;16280.185990700418;16691.24889379981;17095.145242737814;7247.347738703436;7289.927100729031;7321.890171647429;7407.703691852374;7445.10658720957;4564.931526027112;4588.197065513522;4674.5325467452985;4681.8361357353015;4842.564169224786;3359.6304406515264;3437.862485500552;3439.5528581284275;3451.5858097028517;3454.792712437262;554.603458527155;622.0917460507709;626.3141859663662;627.4729227448873;628.0391001767304;487.9292502587105;505.7092172001114;534.5242733966772;537.5699440447704;560.0451230651729;9373.671921482852;9446.338756286994;9580.281478889112;9711.562979665932;9847.704568862946;574.7729646789495;629.2071989293523;634.9269833969153;640.6380395076767;649.233903993283;4053.148838743838;4227.3447615619625;4430.091831174602;4449.41486599834;4526.366308716782;55565.444345556025;55808.16287755687;55878;65107.34892651108;78738;75317.24682753212;76351;77082.61458692783;78392;79466;55551.44448555543;69443.65278173678;70590.64704676444;70652.29347706457;71140.2885971144;8874.778130546789;9159.129882661136;9264.166225039779;9275.76810579741;9291.953540232256;48481.41522560211;48810;49075.75462122667;49398.25902611535;50839.2374114396;64351.67824161037;67245.66377168083;67944.32055679578;68985.31014689789;69647.65176174087;9656.855147172939;9887.456189909624;10489;10725.89274107249;10822.729431764268;12358.752824943631;12674.366281686063;12932.288724120264;12944.223346599234;13009.804852927404;11928.343941083323;11954.521819127138;11958;12174;12375.195612285173;11682;11817.881821181678;11954.222975506564;12115.515379384726;12484.063695222712;11840.526378944745;11978.520859165885;12010.939945300217;12039.75920481603;12216.389180541115;10039.648612298535;10208.795824083329;10406.167506599606;10513.369197848153;10591.152707783513;9655.179309758749;9812.460314682476;9991.400515969066;10058.798824023625;10102.494875256061 18:10:35 INFO - PROCESS | 9746 | __end_tp_report 18:10:35 INFO - PROCESS | 9746 | __start_cc_report 18:10:35 INFO - PROCESS | 9746 | _x_x_mozilla_cycle_collect,1118 18:10:35 INFO - PROCESS | 9746 | __end_cc_report 18:10:35 INFO - PROCESS | 9746 | __startTimestamp1479953435257__endTimestamp 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | ------- Summary: start ------- 18:10:35 INFO - PROCESS | 9746 | Number of tests: 6 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#0] dojo.html Cycles:165 Average:5387.69 Median:5583.66 stddev:587.66 (10.5%) stddev-sans-first:562.44 18:10:35 INFO - PROCESS | 9746 | Values: 3142.1 3187.3 3193.0 3210.9 3213.7 5387.3 5509.7 5515.9 5519.3 5535.4 5451.3 5480.7 5493.9 5497.3 5528.8 4957.7 4975.1 5017.4 5032.9 5039.2 4776.0 4795.2 4969.9 5025.0 5052.2 4870.6 4907.3 4914.3 4940.3 4981.0 4986.6 5011.4 5058.2 5061.8 5092.1 4705.6 4982.2 5000.4 5011.3 5043.1 5166.1 5291.9 5325.1 5326.2 5361.1 5701.9 5709.9 5789.7 5815.6 5819.8 5672.0 5831.8 5846.2 5860.6 5863.1 5364.7 5368.7 5394.8 5397.1 5452.3 5855.1 5886.5 5889.1 5891.4 5891.4 5671.9 5675.8 5679.1 5689.3 5694.8 5532.9 5596.5 5701.0 5766.6 5769.2 5795.1 5795.3 5795.3 5803.5 5823.2 5743.2 5794.3 5798.0 5807.4 5822.2 4396.7 4427.5 4462.0 4476.3 4531.4 4005.3 4038.5 4050.3 4060.1 4071.9 5507.4 5512.1 5515.9 5517.3 5518.9 5668.5 5730.1 5731.2 5810.0 5828.7 5444.3 5485.0 5498.5 5498.8 5499.1 5022.4 5030.7 5032.7 5033.5 5033.7 5899.4 5903.5 5914.3 5963.9 5980.7 5845.7 5848.4 5855.8 5863.6 5873.5 6011.1 6022.0 6023.7 6027.5 6027.5 5536.0 5583.8 5595.7 5746.6 5753.7 5740.8 5797.3 5812.4 5829.6 5844.7 5647.8 5658.3 5658.6 5662.9 5666.6 5453.2 5520.8 5644.0 5661.5 5662.6 5566.6 5584.3 5600.3 5645.5 5673.4 5682.3 5706.7 5715.1 5716.6 5725.0 5443.6 5577.4 5583.7 5583.8 5588.4 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#1] ext.html Cycles:180 Average:67248.19 Median:38039.50 stddev:145713.22 (383.1%) stddev-sans-first:146036.00 18:10:35 INFO - PROCESS | 9746 | Values: 575.0 611.0 640.1 646.3 660.3 35861.3 45250.8 46517.5 46557.3 48874.3 47128.3 47669.0 47739.8 47740.3 47777.3 8274.0 8727.0 8872.2 8880.0 8882.4 8258.8 10348.5 10613.2 10621.7 10867.7 10692.0 10746.1 10750.8 10751.5 10753.4 10635.6 10710.1 10713.8 10729.8 10734.4 10460.2 10516.5 10519.6 10526.1 10531.8 43623.0 44035.3 44048.6 44068.0 44172.3 3887.1 3902.6 3961.3 3994.9 4004.6 33078.5 33390.2 33405.5 33610.5 33724.8 4540.8 4615.3 4630.7 4646.6 4672.3 367319.0 367395.0 367862.0 368030.0 368217.0 63954.7 64169.7 64226.0 64476.0 64556.0 39239.6 40412.6 40696.0 42447.0 42500.6 17098.7 17160.7 17244.4 17251.9 17263.1 11684.1 11744.1 12747.6 13292.1 13456.5 19536.8 20392.6 20417.2 20521.2 20662.9 7334.0 7359.2 7511.4 7704.2 7735.7 970.9 1000.3 1031.0 1075.7 1084.8 33739.3 34311.8 34367.7 34464.3 34506.0 1163.3 1175.9 1192.0 1220.7 1281.4 17850.4 17859.5 17895.7 17958.3 18020.7 663584.0 679346.0 679890.0 829644.0 831382.0 61903.7 62848.4 63050.7 63164.7 63166.7 1316.9 1385.0 1396.5 1413.5 1448.5 31305.2 34668.8 35063.1 35065.3 35071.0 53555.0 54209.0 54271.5 54324.0 54355.0 447783.0 450706.0 452950.0 454068.0 455148.0 27623.3 27733.7 27980.0 28090.2 30925.1 43698.3 48718.5 48729.5 48973.0 49059.3 40734.3 43099.8 43109.8 43302.4 43707.0 36532.6 37138.3 37665.6 38177.0 38440.0 41542.6 41798.4 42554.8 42837.1 42884.6 34438.8 37217.8 37474.0 37902.0 38769.2 28237.6 28239.4 28525.6 28547.0 28615.9 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#2] jquery.html Cycles:180 Average:30234.63 Median:13203.87 stddev:86278.88 (653.4%) stddev-sans-first:86491.81 18:10:35 INFO - PROCESS | 9746 | Values: 390.5 405.8 413.5 419.3 420.7 14320.6 16445.0 19164.2 19563.6 19786.2 19784.8 20088.7 20268.4 20330.7 20427.6 5631.5 5640.9 5754.2 5800.9 5872.4 4212.3 4406.0 5705.7 5798.3 5802.8 6112.9 6402.6 6408.0 6541.6 6546.7 6260.4 6355.9 6395.5 6399.4 6511.1 5632.4 5634.1 5640.9 5641.2 5644.8 21846.7 22529.4 22717.1 23592.5 23846.6 2352.4 2561.1 2599.0 2897.0 2902.9 10309.9 10454.7 10848.0 10858.3 10933.8 1896.3 1997.4 2003.0 2004.2 2069.1 83484.0 86112.1 87342.0 88355.6 88672.0 11420.7 11547.6 11578.6 11613.5 11849.2 16348.3 16348.7 16368.9 16371.7 16384.0 8601.6 8729.8 8738.5 8774.2 8803.7 8412.2 8430.3 8486.8 8689.1 8711.9 4946.2 4966.9 4970.2 4999.9 5060.7 1983.7 2066.2 2068.0 2090.3 2101.3 938.2 959.1 964.5 1001.2 1043.3 19957.4 20104.8 20192.4 20384.6 20484.0 993.7 1014.8 1027.6 1039.3 1073.3 10475.5 10613.8 11196.0 11337.8 11386.9 511779.0 519131.0 523961.0 528388.0 540228.0 61401.4 70176.6 88714.0 89276.6 89517.6 980.4 1026.4 1064.9 1092.5 1114.6 17373.0 17518.9 17644.5 17720.6 18074.5 44455.3 44537.1 44686.8 45549.8 46519.3 61980.4 63087.7 63137.7 63490.7 66497.3 8415.0 8479.9 8524.5 8809.7 9054.2 11628.2 13309.3 13437.8 13505.9 13581.0 11497.9 11512.7 11547.0 11763.9 11794.4 11408.3 11712.4 11832.4 12001.5 12366.6 11288.9 11866.6 11891.2 12224.4 12690.3 8570.6 8827.8 8862.8 9215.0 9394.3 11241.9 11724.9 11849.2 12093.8 12365.0 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#3] mootools.html Cycles:180 Average:5682.31 Median:5208.98 stddev:3054.40 (58.6%) stddev-sans-first:3046.84 18:10:35 INFO - PROCESS | 9746 | Values: 1505.1 1535.0 1650.9 1789.0 1790.2 8071.9 8575.4 8587.0 8587.4 8600.8 7297.9 7491.9 7495.0 7674.9 8479.1 2156.5 2397.3 2470.9 2474.5 2502.1 2453.3 2484.3 2487.2 2491.5 2495.0 2392.6 2417.1 2418.7 2421.7 2421.7 2379.5 2424.3 2442.1 2446.2 2448.3 2417.3 2428.7 2444.5 2451.0 2451.4 8349.6 8428.5 8433.7 8441.2 8569.0 5268.2 5407.3 5416.9 5418.1 5425.2 3334.1 3459.7 3461.4 3465.1 3493.1 1078.8 1125.5 1158.8 1165.7 1195.4 11669.2 11763.0 11767.4 11795.8 11796.4 4826.0 4968.9 4996.5 5107.8 5122.6 9352.9 9374.0 9405.4 9432.8 9436.4 5450.7 5450.7 5452.3 5452.5 5455.9 4922.5 5030.5 5035.4 5074.8 5085.4 3579.6 3721.2 3825.9 3954.7 3970.1 1169.0 1181.9 1206.8 1211.6 1219.6 896.2 982.7 1014.7 1037.2 1044.0 5812.0 5890.6 5944.6 6154.6 6173.9 994.3 1002.4 1009.6 1019.6 1023.9 4217.3 4261.2 4310.0 4313.8 4464.9 10115.9 10330.7 10343.6 10419.6 10440.8 10254.7 10256.1 10269.0 10287.6 10295.4 7663.4 7950.3 7981.2 7987.3 8109.4 6002.7 6093.8 6109.8 6146.9 6239.3 9651.9 9660.5 9665.6 9679.4 9689.4 9638.9 9932.9 10028.7 10044.1 10044.7 7667.3 7779.3 7793.5 7798.0 7801.3 7061.4 7204.2 8042.5 8100.9 8167.3 7239.9 7273.6 7451.3 7466.6 7479.3 7336.0 7352.4 7372.4 7391.0 7452.0 6864.2 6904.0 6947.9 7019.4 7021.1 5161.7 5256.3 5262.9 5375.7 5470.8 5304.5 5389.1 5421.1 5441.8 5533.1 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#4] prototype.html Cycles:180 Average:4712.50 Median:5409.86 stddev:1383.07 (25.6%) stddev-sans-first:1347.63 18:10:35 INFO - PROCESS | 9746 | Values: 349.6 351.3 356.8 360.7 362.6 5414.6 5419.5 5424.7 5437.6 5459.3 5322.9 5337.5 5355.3 5401.9 5405.2 4009.7 4160.7 4194.0 4197.0 4280.2 4139.6 4143.9 4152.0 4196.3 4218.7 3967.3 4157.7 4160.8 4168.3 4169.2 4070.7 4078.6 4155.8 4179.7 4194.8 3695.0 3706.7 3720.3 3726.3 3733.4 4966.3 5163.1 5188.2 5264.6 5283.1 4609.7 4759.3 4760.4 4790.7 4801.9 5534.6 5595.3 5605.7 5614.2 5639.6 3965.9 4054.6 4095.8 4101.3 4103.6 5774.3 5784.9 5795.3 5798.2 5806.6 4120.4 4125.9 4126.8 4144.5 4159.6 4022.4 4202.4 4217.3 4226.6 4243.0 4771.2 4784.1 4791.4 4811.3 4835.6 5650.2 5655.6 5674.0 5678.9 5692.8 1339.4 1390.9 1409.7 1422.4 1427.4 954.0 955.1 967.2 981.2 991.3 5140.6 5182.4 5188.7 5219.1 5222.4 5435.0 5438.4 5451.5 5462.4 5476.4 5190.1 5241.5 5307.3 5323.2 5386.0 2905.3 2905.3 2906.9 2916.7 2921.9 5654.3 5657.4 5658.2 5686.9 5713.5 5853.2 5857.3 5883.8 5902.4 5902.6 5936.3 5948.2 5952.9 6010.9 6021.5 5562.3 5739.6 5771.5 5777.6 5781.4 5675.9 5687.4 5694.8 5696.3 5696.4 5680.7 5926.3 5928.9 5982.6 6021.9 4093.3 4138.0 4174.7 4186.8 4209.6 5749.5 5809.2 5817.6 5837.7 5849.2 5404.3 5563.7 5699.9 5703.2 5724.3 5576.9 5602.6 5602.7 5615.4 5617.7 5546.4 5566.3 5580.5 5593.7 5600.3 5414.5 5645.4 5660.3 5681.8 5686.6 5562.7 5564.4 5564.5 5564.5 5592.2 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - PROCESS | 9746 | [#5] yui.html Cycles:180 Average:17187.42 Median:25672.47 stddev:22501.40 (87.6%) stddev-sans-first:22530.84 18:10:35 INFO - PROCESS | 9746 | Values: 790.4 812.2 840.3 855.0 870.5 14033.5 15867.3 16075.7 16077.8 16201.4 14719.9 14894.5 14989.5 15151.2 15340.7 724.1 838.8 858.8 858.9 858.9 740.3 836.2 859.3 863.3 865.0 901.3 902.3 903.9 904.4 904.6 743.0 899.0 901.7 902.9 903.2 560.1 634.8 656.2 659.1 660.1 14250.2 14260.6 14273.6 14279.5 14309.9 13900.2 14170.8 14173.1 14193.5 14245.1 12157.5 12176.7 12179.0 12381.8 12434.0 4083.0 4083.9 4094.3 4101.1 4145.3 65974.3 67669.3 67677.0 68504.7 69617.7 10060.6 10148.3 10323.3 10449.3 10529.0 16047.8 16108.8 16280.2 16691.2 17095.1 7247.3 7289.9 7321.9 7407.7 7445.1 4564.9 4588.2 4674.5 4681.8 4842.6 3359.6 3437.9 3439.6 3451.6 3454.8 554.6 622.1 626.3 627.5 628.0 487.9 505.7 534.5 537.6 560.0 9373.7 9446.3 9580.3 9711.6 9847.7 574.8 629.2 634.9 640.6 649.2 4053.1 4227.3 4430.1 4449.4 4526.4 55565.4 55808.2 55878.0 65107.3 78738.0 75317.2 76351.0 77082.6 78392.0 79466.0 55551.4 69443.7 70590.6 70652.3 71140.3 8874.8 9159.1 9264.2 9275.8 9292.0 48481.4 48810.0 49075.8 49398.3 50839.2 64351.7 67245.7 67944.3 68985.3 69647.7 9656.9 9887.5 10489.0 10725.9 10822.7 12358.8 12674.4 12932.3 12944.2 13009.8 11928.3 11954.5 11958.0 12174.0 12375.2 11682.0 11817.9 11954.2 12115.5 12484.1 11840.5 11978.5 12010.9 12039.8 12216.4 10039.6 10208.8 10406.2 10513.4 10591.2 9655.2 9812.5 9991.4 10058.8 10102.5 18:10:35 INFO - PROCESS | 9746 | -------- Summary: end -------- 18:10:35 INFO - PROCESS | 9746 | 18:10:35 INFO - TEST-INFO | 9746: exit 0 18:10:36 INFO - TEST-OK | dromaeo_css | took 1114640ms 18:10:36 INFO - TEST-START | kraken 18:10:36 INFO - operating with platform_type : linux_ 18:10:36 INFO - Initialising browser for kraken test... 18:10:36 INFO - TEST-INFO | started process 10061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kQ69B/profile http://localhost:40510/getInfo.html) 18:10:38 ERROR - PROCESS | 10061 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 18:10:39 INFO - PROCESS | 10061 | __metrics Screen width/height:1600/1200 18:10:39 INFO - PROCESS | 10061 | colorDepth:24 18:10:39 INFO - PROCESS | 10061 | Browser inner width/height: 1024/697 18:10:39 INFO - PROCESS | 10061 | __metrics 18:10:40 INFO - PROCESS | 10061 | 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" 18:10:40 INFO - PROCESS | 10061 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:40 INFO - PROCESS | 10061 | console.error: PushService: 18:10:40 INFO - PROCESS | 10061 | stateChangeProcessEnqueue: Error transitioning state 18:10:40 INFO - PROCESS | 10061 | UnknownError 18:10:41 INFO - TEST-INFO | 10061: exit 0 18:10:41 INFO - Browser initialized. 18:10:41 INFO - Running cycle 1/1 for kraken test... 18:10:41 INFO - TEST-INFO | started process 10153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kQ69B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:53 INFO - PROCESS | 10153 | RSS: Main: 144732160 18:10:53 INFO - PROCESS | 10153 | 18:10:55 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40510/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:56 INFO - PROCESS | 10153 | RSS: Main: 185860096 18:10:56 INFO - PROCESS | 10153 | 18:10:59 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40510/tests/kraken/driver.html?testName=audio-dft) 18:10:59 INFO - PROCESS | 10153 | RSS: Main: 175042560 18:10:59 INFO - PROCESS | 10153 | 18:11:02 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40510/tests/kraken/driver.html?testName=audio-fft) 18:11:03 INFO - PROCESS | 10153 | RSS: Main: 267108352 18:11:03 INFO - PROCESS | 10153 | 18:11:05 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40510/tests/kraken/driver.html?testName=audio-oscillator) 18:11:05 INFO - PROCESS | 10153 | RSS: Main: 172814336 18:11:05 INFO - PROCESS | 10153 | 18:11:07 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:11:08 INFO - PROCESS | 10153 | RSS: Main: 175517696 18:11:08 INFO - PROCESS | 10153 | 18:11:11 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40510/tests/kraken/driver.html?testName=imaging-darkroom) 18:11:12 INFO - PROCESS | 10153 | RSS: Main: 213946368 18:11:12 INFO - PROCESS | 10153 | 18:11:15 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40510/tests/kraken/driver.html?testName=imaging-desaturate) 18:11:16 INFO - PROCESS | 10153 | RSS: Main: 212541440 18:11:16 INFO - PROCESS | 10153 | 18:11:18 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40510/tests/kraken/driver.html?testName=json-parse-financial) 18:11:19 INFO - PROCESS | 10153 | RSS: Main: 212041728 18:11:19 INFO - PROCESS | 10153 | 18:11:20 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:11:21 INFO - PROCESS | 10153 | RSS: Main: 174219264 18:11:21 INFO - PROCESS | 10153 | 18:11:23 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:11:23 INFO - PROCESS | 10153 | RSS: Main: 181469184 18:11:23 INFO - PROCESS | 10153 | 18:11:25 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:26 INFO - PROCESS | 10153 | RSS: Main: 190529536 18:11:26 INFO - PROCESS | 10153 | 18:11:28 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:29 INFO - PROCESS | 10153 | RSS: Main: 199294976 18:11:29 INFO - PROCESS | 10153 | 18:11:32 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:32 INFO - PROCESS | 10153 | RSS: Main: 195756032 18:11:32 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | Cycle 1(1): loaded http://localhost:40510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40510/tests/kraken/driver.html?testName=ai-astar) 18:11:34 INFO - PROCESS | 10153 | RSS: Main: 246214656 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | __start_tp_report 18:11:34 INFO - PROCESS | 10153 | _x_x_mozilla_page_load 18:11:34 INFO - PROCESS | 10153 | _x_x_mozilla_page_load_details 18:11:34 INFO - PROCESS | 10153 | |i|pagename|runs| 18:11:34 INFO - PROCESS | 10153 | |0;ai-astar;104;112;111;110;112;112;112;113;112;112 18:11:34 INFO - PROCESS | 10153 | |1;audio-beat-detection;143;124;122;167;122;123;122;122;148;124 18:11:34 INFO - PROCESS | 10153 | |2;audio-dft;161;162;160;161;160;161;161;160;161;163 18:11:34 INFO - PROCESS | 10153 | |3;audio-fft;77;75;76;105;76;76;75;76;103;74 18:11:34 INFO - PROCESS | 10153 | |4;audio-oscillator;82;82;116;81;81;82;110;80;82;110 18:11:34 INFO - PROCESS | 10153 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;116 18:11:34 INFO - PROCESS | 10153 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 18:11:34 INFO - PROCESS | 10153 | |7;imaging-desaturate;85;86;87;85;84;85;85;84;85;84 18:11:34 INFO - PROCESS | 10153 | |8;json-parse-financial;51;54;51;50;52;54;50;52;52;50 18:11:34 INFO - PROCESS | 10153 | |9;json-stringify-tinderbox;60;60;60;61;59;59;59;60;60;64 18:11:34 INFO - PROCESS | 10153 | |10;stanford-crypto-aes;75;75;74;75;75;75;75;75;75;74 18:11:34 INFO - PROCESS | 10153 | |11;stanford-crypto-ccm;128;126;141;127;126;133;125;124;165;126 18:11:34 INFO - PROCESS | 10153 | |12;stanford-crypto-pbkdf2;159;160;159;155;152;154;151;152;154;159 18:11:34 INFO - PROCESS | 10153 | |13;stanford-crypto-sha256-iterative;62;62;65;61;62;62;60;62;61;62 18:11:34 INFO - PROCESS | 10153 | __end_tp_report 18:11:34 INFO - PROCESS | 10153 | __start_cc_report 18:11:34 INFO - PROCESS | 10153 | _x_x_mozilla_cycle_collect,1647 18:11:34 INFO - PROCESS | 10153 | __end_cc_report 18:11:34 INFO - PROCESS | 10153 | __startTimestamp1479953494647__endTimestamp 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | ------- Summary: start ------- 18:11:34 INFO - PROCESS | 10153 | Number of tests: 14 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 18:11:34 INFO - PROCESS | 10153 | Values: 104.0 112.0 111.0 110.0 112.0 112.0 112.0 113.0 112.0 112.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:124.00 stddev:15.67 (12.6%) stddev-sans-first:16.08 18:11:34 INFO - PROCESS | 10153 | Values: 143.0 124.0 122.0 167.0 122.0 123.0 122.0 122.0 148.0 124.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 18:11:34 INFO - PROCESS | 10153 | Values: 161.0 162.0 160.0 161.0 160.0 161.0 161.0 160.0 161.0 163.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.00 (15.8%) stddev-sans-first:12.63 18:11:34 INFO - PROCESS | 10153 | Values: 77.0 75.0 76.0 105.0 76.0 76.0 75.0 76.0 103.0 74.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:14.87 (18.2%) stddev-sans-first:15.44 18:11:34 INFO - PROCESS | 10153 | Values: 82.0 82.0 116.0 81.0 81.0 82.0 110.0 80.0 82.0 110.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:11:34 INFO - PROCESS | 10153 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 18:11:34 INFO - PROCESS | 10153 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 18:11:34 INFO - PROCESS | 10153 | Values: 85.0 86.0 87.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.51 (2.9%) stddev-sans-first:1.58 18:11:34 INFO - PROCESS | 10153 | Values: 51.0 54.0 51.0 50.0 52.0 54.0 50.0 52.0 52.0 50.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.48 (2.5%) stddev-sans-first:1.56 18:11:34 INFO - PROCESS | 10153 | Values: 60.0 60.0 60.0 61.0 59.0 59.0 59.0 60.0 60.0 64.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:11:34 INFO - PROCESS | 10153 | Values: 75.0 75.0 74.0 75.0 75.0 75.0 75.0 75.0 75.0 74.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:127.50 stddev:12.62 (9.9%) stddev-sans-first:13.30 18:11:34 INFO - PROCESS | 10153 | Values: 128.0 126.0 141.0 127.0 126.0 133.0 125.0 124.0 165.0 126.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:157.00 stddev:3.44 (2.2%) stddev-sans-first:3.41 18:11:34 INFO - PROCESS | 10153 | Values: 159.0 160.0 159.0 155.0 152.0 154.0 151.0 152.0 154.0 159.0 18:11:34 INFO - PROCESS | 10153 | 18:11:34 INFO - PROCESS | 10153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.36 18:11:34 INFO - PROCESS | 10153 | Values: 62.0 62.0 65.0 61.0 62.0 62.0 60.0 62.0 61.0 62.0 18:11:34 INFO - PROCESS | 10153 | -------- Summary: end -------- 18:11:34 INFO - PROCESS | 10153 | 18:11:35 INFO - TEST-INFO | 10153: exit 0 18:11:35 INFO - TEST-OK | kraken | took 59818ms 18:11:35 INFO - SUITE-END | took 1174s 18:11:36 INFO - Completed test suite (00:19:34) 18:11:36 INFO - javascript benchmark 18:11:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.0573827851645, 3187.2509960159346, 3192.9942068248506, 3210.8876189333378, 3213.66256543063, 5387.272718183049, 5509.724513774316, 5515.944840551593, 5519.282493275873, 5535.446455354462, 5451.291332126828, 5480.725963701819, 5493.890122197554, 5497.285352904127, 5528.806491772789, 4957.727324997124, 4975.079610272093, 5017.422996355429, 5032.874178145557, 5039.168537191359, 4775.952240477585, 4795.160846851804, 4969.925451118236, 5025.020121076392, 5052.242163675442, 4870.634702397317, 4907.2639104134305, 4914.287428322891, 4940.25896115582, 4981.0, 4986.626003049768, 5011.398632164145, 5058.2412638104215, 5061.797528098871, 5092.134337162654, 4705.6470764692785, 4982.227754698028, 5000.42495113063, 5011.3485246918035, 5043.092243396187, 5166.07010738067, 5291.947080529184, 5325.121354976424, 5326.227696983954, 5361.142217245222, 5701.914471282934, 5709.942900570983, 5789.710514474302, 5815.592908496407, 5819.7672093116225, 5672.0, 5831.825045248649, 5846.239988801429, 5860.560457965627, 5863.061910094407, 5364.731763411853, 5368.677879327252, 5394.838154855361, 5397.055515284809, 5452.263944367499, 5855.092460668603, 5886.499647529922, 5889.087191485327, 5891.351951285355, 5891.351951285355, 5671.886562268732, 5675.829725108253, 5679.091345384802, 5689.260396148474, 5694.800681976194, 5532.889342213133, 5596.524295434852, 5701.0, 5766.625169363978, 5769.1923130761725, 5795.1017592273265, 5795.275590551181, 5795.275590551181, 5803.47768700819, 5823.155642431823, 5743.2246646703, 5794.275715535558, 5797.971010144923, 5807.361190269067, 5822.155787410802, 4396.736195828261, 4427.490838553543, 4461.977690111528, 4476.328550717419, 4531.3882625845745, 4005.319095753729, 4038.5355684096116, 4050.311447054008, 4060.0864805419137, 4071.857484988011, 5507.421720719347, 5512.118061110203, 5515.944840551623, 5517.282753242052, 5518.91721624176, 5668.489835914705, 5730.054541000688, 5731.197632331477, 5810.0, 5828.708564571754, 5444.3194600674915, 5484.972575137099, 5498.45015498447, 5498.752556134984, 5499.120140777456, 5022.397312322545, 5030.673006254582, 5032.72320022395, 5033.521815427602, 5033.672811267256, 5899.380565040695, 5903.468687818117, 5914.26071741041, 5963.880722385528, 5980.73086711099, 5845.707714614337, 5848.444397782204, 5855.765769369177, 5863.648181109147, 5873.500752436091, 6011.128386384037, 6021.969890150521, 6023.728932198149, 6027.547933904887, 6027.547933904887, 5536.0, 5583.776648934159, 5595.664260144405, 5746.597738158456, 5753.683547404933, 5740.770369185186, 5797.304323481209, 5812.360640329645, 5829.562782791223, 5844.736986835687, 5647.830565083054, 5658.349289831722, 5658.603897727119, 5662.915056274077, 5666.575006874584, 5453.209284653783, 5520.779168833202, 5644.040513112863, 5661.547076233974, 5662.57530685192, 5566.554675625859, 5584.329880414376, 5600.299962504687, 5645.548356131418, 5673.3759286477625, 5682.261306030189, 5706.743196556248, 5715.057015592547, 5716.571257155647, 5725.026745453366, 5443.591730620298, 5577.44225577439, 5583.664980101207, 5583.776648933997, 5588.385277619377], "value": 5349.705706518177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9593236242401, 610.9572329936904, 640.0878747784406, 646.3213625693021, 660.3363619562339, 35861.28277434453, 45250.773746131264, 46517.534824651746, 46557.30164047542, 48874.26688599674, 47128.29307560389, 47669.0, 47739.761301193445, 47740.28389574151, 47777.28334074992, 8274.0, 8726.95636521818, 8872.20150186483, 8880.0, 8882.422642528216, 8258.752237432856, 10348.534315955763, 10613.150947924187, 10621.681349559487, 10867.728306792314, 10692.0, 10746.140308775319, 10750.838737418944, 10751.51618177184, 10753.354798712064, 10635.57457701691, 10710.089642380408, 10713.83929241062, 10729.83905241422, 10734.355938643628, 10460.163186945027, 10516.474176291154, 10519.579216831318, 10526.10528105112, 10531.84202236967, 43623.0, 44035.33946990798, 44048.55951440477, 44068.0, 44172.337414938804, 3887.086534664352, 3902.6292502212245, 3961.2869683456966, 3994.8801535953967, 4004.5795191504762, 33078.50382244268, 33390.165245869044, 33405.498917516255, 33610.49584256214, 33724.83137584321, 4540.7502587357685, 4615.26155815068, 4630.699004564726, 4646.605038571725, 4672.345871577982, 367319.0, 367395.0, 367862.0, 368030.0, 368217.0, 63954.6802265995, 64169.679151603945, 64226.0, 64476.03285950715, 64556.0, 39239.60760392417, 40412.59587404088, 40696.0, 42447.0, 42500.57499424966, 17098.743518847226, 17160.742588861176, 17244.396446124578, 17251.913740431217, 17263.05053222085, 11684.065274777997, 11744.060475161967, 12747.617571472685, 13292.136011159244, 13456.529021484397, 19536.76232267061, 20392.592148156953, 20417.183312667326, 20521.179152834018, 20662.896685516476, 7333.963330183422, 7359.227281135511, 7511.399088072941, 7704.152543220242, 7735.651895664709, 970.9077637624414, 1000.309786247487, 1031.0, 1075.6611667324767, 1084.810158222308, 33739.29904697141, 34311.82844085814, 34367.656323436946, 34464.310713786086, 34506.0, 1163.2555164694602, 1175.9294442333487, 1192.0165863162924, 1220.700928272579, 1281.4489769399247, 17850.386760030535, 17859.46421607354, 17895.73156402655, 17958.304164122244, 18020.729689054675, 663584.0, 679346.0, 679890.0, 829644.0, 831382.0, 61903.6904815473, 62848.37151628425, 63050.68474657597, 63164.68417657882, 63166.68416657979, 1316.8748968847945, 1384.9653758655913, 1396.4902810474105, 1413.4699487692114, 1448.5147475595584, 31305.217369565944, 34668.82665586656, 35063.12342191364, 35065.29869402649, 35071.0, 53555.0, 54208.99999999842, 54271.45728542664, 54324.0, 54355.0, 447783.0, 450706.0, 452950.0, 454068.0, 455148.0, 27623.30941726473, 27733.722662773922, 27980.0, 28090.157295281173, 30925.072247832602, 43698.34452483279, 48718.5128148714, 48729.5127048725, 48973.0, 49059.264111039076, 40734.30296187434, 43099.784501077294, 43109.78445107755, 43302.350464743686, 43707.0, 36532.63467365292, 37138.25723485461, 37665.62334376621, 38177.0, 38440.0, 41542.58457415387, 41798.373024405264, 42554.78722606367, 42837.14325713531, 42884.571154289304, 34438.827805861816, 37217.81391093027, 37474.0, 37902.0, 38769.224615506966, 28237.57643635306, 28239.435211295247, 28525.572116417854, 28547.0, 28615.856920716094], "value": 21132.422943992395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5001597954619, 405.84780707234785, 413.5285774217392, 419.3186072631973, 420.68658849157384, 14320.641983950407, 16445.0, 19164.233430662756, 19563.608727825434, 19786.208551657917, 19784.802151978474, 20088.69866951997, 20268.391948241577, 20330.69503957438, 20427.591448171028, 5631.465010823965, 5640.887182256352, 5754.165645981351, 5800.941990580082, 5872.442117998783, 4212.283911735012, 4406.030673251879, 5705.74324155414, 5798.275215598051, 5802.82591522255, 6112.908306375408, 6402.6158430494315, 6408.038794180864, 6541.574797638162, 6546.672666366662, 6260.405261500173, 6355.9364406356035, 6395.488360931115, 6399.36006399361, 6511.055896894971, 5632.436756324335, 5634.098544232944, 5640.915386269209, 5641.182028605829, 5644.802431914904, 21846.672299915514, 22529.436764080867, 22717.091316347327, 23592.528149437087, 23846.642300365507, 2352.447174913911, 2561.103613735178, 2599.0, 2896.985515072432, 2902.85485725715, 10309.948450257702, 10454.738631534197, 10848.02367786895, 10858.34849909008, 10933.781324373547, 1896.3268039845793, 1997.4107638246608, 2002.979970200294, 2004.1983206717284, 2069.1102825784906, 83484.0, 86112.13887861103, 87342.0, 88355.55822220912, 88672.0, 11420.657380278604, 11547.595834145764, 11578.594749183738, 11613.535458581562, 11849.229800062969, 16348.264328105264, 16348.673026539402, 16368.918155409385, 16371.672566548603, 16384.0, 8601.612927418157, 8729.825403491895, 8738.519381434082, 8774.166454186841, 8803.691870784492, 8412.200840920103, 8430.32557395407, 8486.787830304293, 8689.13108689126, 8711.869321960176, 4946.233333833262, 4966.925496117561, 4970.229614409773, 4999.875003124951, 5060.696358218519, 1983.6826107822967, 2066.163203902422, 2067.958640827175, 2090.2997495839063, 2101.327575175929, 938.2025278513346, 959.1176117971344, 964.4984608003799, 1001.1890368801148, 1043.2540733375522, 19957.401277961686, 20104.793712377304, 20192.39422817318, 20384.592308153755, 20484.0, 993.7316924430363, 1014.8426993815971, 1027.5786927359895, 1039.2569312941284, 1073.3345325897992, 10475.47622618866, 10613.787724245472, 11196.0, 11337.773244535063, 11386.943065284786, 511779.0, 519131.0, 523961.0, 528388.0, 540228.0, 61401.38598613957, 70176.6491167541, 88714.0, 89276.5536172315, 89517.55241223752, 980.4362491567234, 1026.4046852825343, 1064.8881867403966, 1092.4646923007829, 1114.6321713834416, 17373.0, 17518.91240543789, 17644.470665880042, 17720.64558708793, 18074.548136296697, 44455.33317000312, 44537.10508816916, 44686.77656611696, 45549.77225113986, 46519.302210466194, 61980.380196199265, 63087.6845615769, 63137.684311578145, 63490.68254658697, 66497.33502664912, 8415.032271288881, 8479.869678844458, 8524.488530688179, 8809.735707928772, 9054.230390416888, 11628.244164129304, 13309.267990260241, 13437.798433023318, 13505.932470337586, 13581.0, 11497.885021149681, 11512.654620361403, 11547.0, 11763.941180294043, 11794.410279485819, 11408.258463199865, 11712.355820429617, 11832.408379580815, 12001.519939202333, 12366.62900112998, 11288.903991844312, 11866.584669536525, 11891.227070240408, 12224.449899754354, 12690.302033388252, 8570.600521671307, 8827.779305517413, 8862.778430539289, 9214.953925230599, 9394.295427842802, 11241.943790280997, 11724.941375293069, 11849.229800062969, 12093.81859272094, 12365.0], "value": 9517.224749171646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.0894209003552, 1534.9539513814586, 1650.8514233718963, 1789.0071010589127, 1790.1586254460415, 8071.91928080719, 8575.356848236375, 8587.012493563234, 8587.441816281953, 8600.784980375494, 7297.927020729791, 7491.850162996737, 7495.025646665939, 7674.884876726854, 8479.06730259671, 2156.5147841735643, 2397.3167647220544, 2470.9011639534397, 2474.4679893822827, 2502.1492692484553, 2453.313072339739, 2484.291976786616, 2487.166799122296, 2491.489244704831, 2495.02693949359, 2392.605220138675, 2417.093589903786, 2418.7097548294228, 2421.721502027263, 2421.721502027272, 2379.5478859016816, 2424.309071914505, 2442.1452491627965, 2446.1805295226122, 2448.2655203438985, 2417.3473162246096, 2428.672129262545, 2444.4866578018637, 2450.987745061281, 2451.36264571211, 8349.582520873932, 8428.45215061019, 8433.662653493853, 8441.198086181865, 8569.0, 5268.209768534713, 5407.324084489439, 5416.945830541684, 5418.078926582491, 5425.213344065128, 3334.149791803099, 3459.705924996378, 3461.44616861301, 3465.128830431564, 3493.0917961330238, 1078.8273876179774, 1125.482278152051, 1158.7624536969902, 1165.702745799824, 1195.4261954262004, 11669.241499302518, 11763.0, 11767.352795596238, 11795.764084718343, 11796.35120068396, 4826.0, 4968.850934471971, 4996.5003499650475, 5107.770150343244, 5122.590192784568, 9352.859707104399, 9373.953130234306, 9405.43567385959, 9432.764180895532, 9436.433813971184, 5450.672959622435, 5450.700211488406, 5452.345718513724, 5452.454754524595, 5455.945440545624, 4922.50774922512, 5030.496950304941, 5035.420926593415, 5074.797008119708, 5085.389753229636, 3579.6241394653707, 3721.2371463849845, 3825.904352391157, 3954.7429417088374, 3970.06703424695, 1168.9590864319878, 1181.8640856301463, 1206.77071356442, 1211.6425654431964, 1219.5975328141692, 896.2337201692459, 982.749398903275, 1014.6702321745462, 1037.1858091398367, 1044.0394836750208, 5811.970940145272, 5890.587658863924, 5944.5838791284195, 6154.599951003171, 6173.876522469525, 994.2692121290845, 1002.4386343647581, 1009.615622786204, 1019.6176433837311, 1023.9436830974219, 4217.283061879488, 4261.232978063978, 4309.956900431018, 4313.805878735465, 4464.866054018385, 10115.898841011496, 10330.741731456774, 10343.586256549654, 10419.635312764169, 10440.843387349196, 10254.692359229235, 10256.12822910061, 10269.0, 10287.639932602324, 10295.3822770634, 7663.386929045663, 7950.324222441157, 7981.201879812089, 7987.321077708344, 8109.351251899834, 6002.669853158118, 6093.847653808691, 6109.7861574844665, 6146.938530614815, 6239.344868788893, 9651.855222171533, 9660.468674222986, 9665.565049572646, 9679.370840895319, 9689.370190937567, 9638.9036109638, 9932.900670993198, 10028.69913902584, 10044.096031357212, 10044.748881277734, 7667.271609197117, 7779.260970207822, 7793.532388056508, 7798.0, 7801.29788319054, 7061.364477197077, 7204.171520275026, 8042.517448953082, 8100.87848682282, 8167.264946154874, 7239.927600723925, 7273.599952002691, 7451.254874512505, 7466.589337586485, 7479.252074792477, 7336.0, 7352.4485663576515, 7372.373348265458, 7391.0, 7452.0, 6864.24493305746, 6903.965480172567, 6947.861042779217, 7019.3682568569075, 7021.087258656342, 5161.690298582097, 5256.264123022704, 5262.921056184084, 5375.731213439234, 5470.753816078366, 5304.549113325256, 5389.083855744611, 5421.1055175895535, 5441.755121019484, 5533.059379905345], "value": 4636.376069058258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5944704143193, 351.26234906695936, 356.839422259983, 360.6898067661812, 362.5848403577903, 5414.62097653164, 5419.485148910857, 5424.701641409721, 5437.6465529740535, 5459.344878614572, 5322.920156197651, 5337.492938170868, 5355.3305836770405, 5401.918971215435, 5405.18922161675, 4009.6591789697763, 4160.7087503874745, 4193.979030104845, 4197.0, 4280.208161490119, 4139.606737359946, 4143.917121657565, 4151.979240103795, 4196.286631272676, 4218.683598730092, 3967.305721498726, 4157.708960372775, 4160.750354978696, 4168.270552653289, 4169.187008533338, 4070.653994410464, 4078.6125318094732, 4155.812988415529, 4179.72205148195, 4194.769287689176, 3695.0, 3706.684931780802, 3720.2559488102215, 3726.2547490502006, 3733.4213196954242, 4966.304717339575, 5163.122269214243, 5188.247704082887, 5264.578833693296, 5283.128283833163, 4609.700369476007, 4759.286107083931, 4760.404949381327, 4790.736509491977, 4801.879953001168, 5534.640248383883, 5595.272614560122, 5605.747741351649, 5614.157876318544, 5639.577031722637, 3965.920681586381, 4054.614811592894, 4095.836166553364, 4101.323281658522, 4103.610157035077, 5774.335951365605, 5784.942150578482, 5795.275590551223, 5798.159266906275, 5806.5645076619, 4120.423140760236, 4125.91748165035, 4126.793660316972, 4144.5026596808575, 4159.627322983408, 4022.3765316376007, 4202.411662367271, 4217.261979153636, 4226.5773422657485, 4242.957570424318, 4771.163102205675, 4784.134187666813, 4791.353167322437, 4811.254255590389, 4835.588974937099, 5650.237217975603, 5655.604107712503, 5674.0, 5678.858028549237, 5692.829215123553, 1339.4039652354804, 1390.8872901678617, 1409.7462456757678, 1422.3670466642452, 1427.4290283886528, 953.9952300238455, 955.1403736637083, 967.2407160379069, 981.1562056631434, 991.2516050381915, 5140.640155189101, 5182.445266420134, 5188.7405629719115, 5219.1388420910125, 5222.399424066281, 5434.972825135849, 5438.428964958702, 5451.465068743054, 5462.399136095027, 5476.397596264408, 5190.11767999441, 5241.528262456397, 5307.2569840222395, 5323.1749078892835, 5386.0, 2905.288204389938, 2905.3027273454218, 2906.9273268168463, 2916.672913824205, 2921.8977335793147, 5654.293213348332, 5657.434256574392, 5658.207850900877, 5686.886262274731, 5713.457221563945, 5853.151293062482, 5857.297124345106, 5883.823485295448, 5902.380250073767, 5902.616329938626, 5936.257967754031, 5948.167256584082, 5952.85117872048, 6010.939890601126, 6021.458068773832, 5562.332520097614, 5739.62692424991, 5771.509421699203, 5777.595568310178, 5781.364049954585, 5675.914861277001, 5687.374388817309, 5694.829155125353, 5696.316442026983, 5696.430356964271, 5680.7443665036, 5926.348101708722, 5928.851778705567, 5982.551308651781, 6021.879562408815, 4093.3450647896193, 4138.0, 4174.666026717795, 4186.790660467025, 4209.557996410455, 5749.453801888814, 5809.1949772898815, 5817.563682723728, 5837.708114594338, 5849.151872978479, 5404.297441332602, 5563.693996830051, 5699.8860022800145, 5703.230063941315, 5724.255846740064, 5576.856744367314, 5602.579806514446, 5602.663840169603, 5615.354234263112, 5617.691026993554, 5546.36216835053, 5566.276384070045, 5580.497755202051, 5593.748281327269, 5600.27196464457, 5414.539764119936, 5645.350784659652, 5660.349059858169, 5681.801136960186, 5686.573506987075, 5562.694051827189, 5564.415736347625, 5564.495976810533, 5564.527015203591, 5592.161175823497], "value": 4276.956620339553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.40324554961, 812.2162113560416, 840.2521755637483, 854.9871751923722, 870.4646642314979, 14033.50882719105, 15867.285972131267, 16075.678486430264, 16077.758833617476, 16201.351945922164, 14719.852801471981, 14894.47869324574, 14989.47536836211, 15151.242437878118, 15340.69318613627, 724.149124778386, 838.7609531283586, 858.845407826591, 858.8840506531632, 858.9141085891423, 740.3041141327162, 836.2264904962915, 859.3383095016833, 863.3438586674141, 864.9956750216271, 901.2519608724742, 902.2871931174398, 903.8779764731776, 904.4482865452102, 904.6426661468716, 743.0, 898.9640414383417, 901.7384958362068, 902.8826252587187, 903.2051794420901, 560.0563051258642, 634.7714822663837, 656.2256537286, 659.116783510094, 660.0594153331531, 14250.2162381069, 14260.643483912881, 14273.57179284623, 14279.500217492337, 14309.856901430956, 13900.235487048209, 14170.787438188436, 14173.14961102327, 14193.503227387095, 14245.145291282453, 12157.51369945201, 12176.695582610506, 12179.0, 12381.75236495265, 12434.0, 4082.9795851020854, 4083.8570650027104, 4094.28350038745, 4101.092068474033, 4145.2952997990415, 65974.34025659777, 67669.32330676679, 67677.0, 68504.65747671279, 69617.65191174012, 10060.597576096874, 10148.289619726549, 10323.32898361604, 10449.268551201494, 10529.0, 16047.839521604634, 16108.838911610734, 16280.185990700418, 16691.24889379981, 17095.145242737814, 7247.347738703436, 7289.927100729031, 7321.890171647429, 7407.703691852374, 7445.10658720957, 4564.931526027112, 4588.197065513522, 4674.5325467452985, 4681.8361357353015, 4842.564169224786, 3359.6304406515264, 3437.862485500552, 3439.5528581284275, 3451.5858097028517, 3454.792712437262, 554.603458527155, 622.0917460507709, 626.3141859663662, 627.4729227448873, 628.0391001767304, 487.9292502587105, 505.7092172001114, 534.5242733966772, 537.5699440447704, 560.0451230651729, 9373.671921482852, 9446.338756286994, 9580.281478889112, 9711.562979665932, 9847.704568862946, 574.7729646789495, 629.2071989293523, 634.9269833969153, 640.6380395076767, 649.233903993283, 4053.148838743838, 4227.3447615619625, 4430.091831174602, 4449.41486599834, 4526.366308716782, 55565.444345556025, 55808.16287755687, 55878.0, 65107.34892651108, 78738.0, 75317.24682753212, 76351.0, 77082.61458692783, 78392.0, 79466.0, 55551.44448555543, 69443.65278173678, 70590.64704676444, 70652.29347706457, 71140.2885971144, 8874.778130546789, 9159.129882661136, 9264.166225039779, 9275.76810579741, 9291.953540232256, 48481.41522560211, 48810.0, 49075.75462122667, 49398.25902611535, 50839.2374114396, 64351.67824161037, 67245.66377168083, 67944.32055679578, 68985.31014689789, 69647.65176174087, 9656.855147172939, 9887.456189909624, 10489.0, 10725.89274107249, 10822.729431764268, 12358.752824943631, 12674.366281686063, 12932.288724120264, 12944.223346599234, 13009.804852927404, 11928.343941083323, 11954.521819127138, 11958.0, 12174.0, 12375.195612285173, 11682.0, 11817.881821181678, 11954.222975506564, 12115.515379384726, 12484.063695222712, 11840.526378944745, 11978.520859165885, 12010.939945300217, 12039.75920481603, 12216.389180541115, 10039.648612298535, 10208.795824083329, 10406.167506599606, 10513.369197848153, 10591.152707783513, 9655.179309758749, 9812.460314682476, 9991.400515969066, 10058.798824023625, 10102.494875256061], "value": 6928.419322521865, "unit": "score"}], "name": "dromaeo_css", "value": 7271.611697194215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 110.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 122.0, 167.0, 122.0, 123.0, 122.0, 122.0, 148.0, 124.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 105.0, 76.0, 76.0, 75.0, 76.0, 103.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 81.0, 81.0, 82.0, 110.0, 80.0, 82.0, 110.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 51.0, 50.0, 52.0, 54.0, 50.0, 52.0, 52.0, 50.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 59.0, 59.0, 59.0, 60.0, 60.0, 64.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 141.0, 127.0, 126.0, 133.0, 125.0, 124.0, 165.0, 126.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 155.0, 152.0, 154.0, 151.0, 152.0, 154.0, 159.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 61.0, 62.0, 62.0, 60.0, 62.0, 61.0, 62.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1459.4, "alertThreshold": 2.0}]} 18:11:36 INFO - Return code: 0 18:11:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:11:36 ERROR - # TBPL SUCCESS # 18:11:36 INFO - Running post-action listener: _resource_record_post_action 18:11:36 INFO - [mozharness: 2016-11-24 02:11:36.427981Z] Finished run-tests step (success) 18:11:36 INFO - Running post-run listener: _resource_record_post_run 18:11:36 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 270336; Write bytes: 357916672; Read time: 40; Write time: 195140 18:11:36 INFO - TinderboxPrint: CPU usage
12.9% 18:11:36 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 40 18:11:36 INFO - TinderboxPrint: I/O write bytes / time
357,916,672 / 195,140 18:11:36 INFO - TinderboxPrint: CPU idle
8,275.9 (87.0%) 18:11:36 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 18:11:36 INFO - TinderboxPrint: Swap in / out
0 / 0 18:11:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108883968; Read time: 0; Write time: 62012 18:11:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248471552; Read time: 28; Write time: 133120 18:11:37 INFO - Running post-run listener: _upload_blobber_files 18:11:37 INFO - Blob upload gear active. 18:11:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:11:37 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 18:11:37 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'] 18:11:37 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 18:11:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:11:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:11:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:38 INFO - (blobuploader) - INFO - Done attempting. 18:11:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:11:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:11:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:39 INFO - (blobuploader) - INFO - Done attempting. 18:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:42 INFO - (blobuploader) - INFO - Done attempting. 18:11:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:11:42 INFO - Return code: 0 18:11:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:11:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:11:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4d4ee1ffb5129979d090b3de3604f648e41906db084ff92f9c4778870698453dcdc48f071bc9004879b2d169b04f072d3c9032232aeddcab2b001b3744aa1f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3989e6e8fbbc634447b09af2cfd8a547841424f4f04f5f874749d2112fc815279a247263d724770ac10846e8c9457f2eed2a35847bc0514d64d226ff652c15c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35ff854c1be758d2003ed49aaf9a33ac8a67eebc40366d9d35684d1d344d644cd67b8f2ae4281c9a11b9767599294853d77c8218a25f545419599191d5710763"} 18:11:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:11:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:11:42 INFO - Contents: 18:11:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4d4ee1ffb5129979d090b3de3604f648e41906db084ff92f9c4778870698453dcdc48f071bc9004879b2d169b04f072d3c9032232aeddcab2b001b3744aa1f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3989e6e8fbbc634447b09af2cfd8a547841424f4f04f5f874749d2112fc815279a247263d724770ac10846e8c9457f2eed2a35847bc0514d64d226ff652c15c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35ff854c1be758d2003ed49aaf9a33ac8a67eebc40366d9d35684d1d344d644cd67b8f2ae4281c9a11b9767599294853d77c8218a25f545419599191d5710763"} 18:11:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:11:42 INFO - Copying logs to upload dir... 18:11:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:11:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.455109 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 18:11:42.056803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 18:11:42.060015) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 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/c4d4ee1ffb5129979d090b3de3604f648e41906db084ff92f9c4778870698453dcdc48f071bc9004879b2d169b04f072d3c9032232aeddcab2b001b3744aa1f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3989e6e8fbbc634447b09af2cfd8a547841424f4f04f5f874749d2112fc815279a247263d724770ac10846e8c9457f2eed2a35847bc0514d64d226ff652c15c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35ff854c1be758d2003ed49aaf9a33ac8a67eebc40366d9d35684d1d344d644cd67b8f2ae4281c9a11b9767599294853d77c8218a25f545419599191d5710763"} build_url:https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/dHphWdpWQZqyhxWsTGb7iQ/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/c4d4ee1ffb5129979d090b3de3604f648e41906db084ff92f9c4778870698453dcdc48f071bc9004879b2d169b04f072d3c9032232aeddcab2b001b3744aa1f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3989e6e8fbbc634447b09af2cfd8a547841424f4f04f5f874749d2112fc815279a247263d724770ac10846e8c9457f2eed2a35847bc0514d64d226ff652c15c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35ff854c1be758d2003ed49aaf9a33ac8a67eebc40366d9d35684d1d344d644cd67b8f2ae4281c9a11b9767599294853d77c8218a25f545419599191d5710763"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 18:11:42.085241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:11:42.085555) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1479952262.532567-1904440140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:11:42.168507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 18:11:42.168845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 18:11:42.169155) ========= ========= Total master_lag: 0.17 =========