builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1475166765.4 results: success (0) buildid: 20160929063004 builduid: 0859d89aeb9e4e5fbc06383e529ec608 revision: 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.402206) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.402710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.403050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.421154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.421899) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 09:32:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.0M=0s 2016-09-29 09:32:45 (85.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.510949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.511738) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.565763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:45.566574) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 09:32:46,065 truncating revision to first 12 chars 2016-09-29 09:32:46,065 Setting DEBUG logging. 2016-09-29 09:32:46,065 attempt 1/10 2016-09-29 09:32:46,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/215adbcb1987?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 09:32:46,370 unpacking tar archive at: autoland-215adbcb1987/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:46.239441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:46.239845) ========= script_repo_revision: 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:46.240315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:46.240640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:32:46.251583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-29 09:32:46.252097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:46 INFO - MultiFileLogger online at 20160929 09:32:46 in /builds/slave/test 09:32:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:32:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:46 INFO - {'append_to_log': False, 09:32:46 INFO - 'base_work_dir': '/builds/slave/test', 09:32:46 INFO - 'blob_upload_branch': 'Autoland', 09:32:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:46 INFO - 'branch': 'Autoland', 09:32:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:46 INFO - 'config_files': ('talos/linux_config.py',), 09:32:46 INFO - 'default_actions': ('clobber', 09:32:46 INFO - 'read-buildbot-config', 09:32:46 INFO - 'download-and-extract', 09:32:46 INFO - 'populate-webroot', 09:32:46 INFO - 'create-virtualenv', 09:32:46 INFO - 'install', 09:32:46 INFO - 'run-tests'), 09:32:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:46 INFO - 'download_minidump_stackwalk': True, 09:32:46 INFO - 'download_symbols': 'ondemand', 09:32:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:46 INFO - 'installer_path': 'installer.exe', 09:32:46 INFO - 'log_level': 'info', 09:32:46 INFO - 'log_name': 'talos', 09:32:46 INFO - 'log_to_console': True, 09:32:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:46 INFO - 'opt_config_files': (), 09:32:46 INFO - 'pip_index': False, 09:32:46 INFO - 'sps_profile': False, 09:32:46 INFO - 'sps_profile_interval': 0, 09:32:46 INFO - 'suite': 'dromaeojs-e10s', 09:32:46 INFO - 'system_bits': '32', 09:32:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:46 INFO - 'title': 'talos-linux64-ix-041', 09:32:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:46 INFO - 'use_talos_json': True, 09:32:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:46 INFO - 'work_dir': 'build'} 09:32:46 INFO - [mozharness: 2016-09-29 16:32:46.844699Z] Running clobber step. 09:32:46 INFO - Running pre-action listener: _resource_record_pre_action 09:32:46 INFO - Running main action method: clobber 09:32:46 INFO - rmtree: /builds/slave/test/build 09:32:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:46 INFO - Running post-action listener: _resource_record_post_action 09:32:46 INFO - [mozharness: 2016-09-29 16:32:46.848207Z] Finished clobber step (success) 09:32:46 INFO - [mozharness: 2016-09-29 16:32:46.848303Z] Running read-buildbot-config step. 09:32:46 INFO - Running pre-action listener: _resource_record_pre_action 09:32:46 INFO - Running main action method: read_buildbot_config 09:32:46 INFO - Using buildbot properties: 09:32:46 INFO - { 09:32:46 INFO - "project": "", 09:32:46 INFO - "product": "firefox", 09:32:46 INFO - "script_repo_revision": "production", 09:32:46 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:32:46 INFO - "repository": "", 09:32:46 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 09:32:46 INFO - "buildid": "20160929063004", 09:32:46 INFO - "pgo_build": "True", 09:32:46 INFO - "basedir": "/builds/slave/test", 09:32:46 INFO - "buildnumber": 250, 09:32:46 INFO - "slavename": "talos-linux64-ix-041", 09:32:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:32:46 INFO - "platform": "ubuntu64_hw", 09:32:46 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 09:32:46 INFO - "branch": "autoland", 09:32:46 INFO - "repo_path": "integration/autoland", 09:32:46 INFO - "revision": "215adbcb1987f3a8e065f4c92a3d4215d3f93dd1", 09:32:46 INFO - "stage_platform": "linux64-pgo", 09:32:46 INFO - "builduid": "0859d89aeb9e4e5fbc06383e529ec608", 09:32:46 INFO - "slavebuilddir": "test" 09:32:46 INFO - } 09:32:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:32:46 INFO - Running post-action listener: _resource_record_post_action 09:32:46 INFO - [mozharness: 2016-09-29 16:32:46.850818Z] Finished read-buildbot-config step (success) 09:32:46 INFO - [mozharness: 2016-09-29 16:32:46.850907Z] Running download-and-extract step. 09:32:46 INFO - Running pre-action listener: _resource_record_pre_action 09:32:46 INFO - Running main action method: download_and_extract 09:32:46 INFO - mkdir: /builds/slave/test/build/tests 09:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:46 INFO - trying https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:32:47 INFO - Downloaded 1361 bytes. 09:32:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:32:47 INFO - Using the following test package requirements: 09:32:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:32:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'jsshell-linux-x86_64.zip'], 09:32:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:32:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:32:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:32:47 INFO - Http code: 200 09:32:47 INFO - Content-Encoding: None 09:32:47 INFO - Content-Type: application/zip 09:32:47 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 09:32:47 INFO - x-amz-cf-id: Qe3ti0UOnhuW2E-O6wjTMBS5Fc7n2X-7TBwmZL2J-ApSxgwz3KIZIQ== 09:32:47 INFO - x-amz-version-id: 6e9l_SvxD91RzorfZd0OOSRaC77VIUK. 09:32:47 INFO - x-cache: Hit from cloudfront 09:32:48 INFO - Expected file size: 21989138 09:32:48 INFO - Obtained file size: 21989138 09:32:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:32:52 INFO - Http code: 200 09:32:52 INFO - Content-Encoding: None 09:32:52 INFO - Content-Type: application/zip 09:32:52 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:32:52 INFO - x-amz-cf-id: OOmwG4WDYfY2iktlAJJB5vkVw69sLQZPVkfpjwASZEzlm4UvC7_ZZA== 09:32:52 INFO - x-amz-version-id: 6e9l_SvxD91RzorfZd0OOSRaC77VIUK. 09:32:52 INFO - x-cache: Hit from cloudfront 09:32:53 INFO - Expected file size: 21989138 09:32:53 INFO - Obtained file size: 21989138 09:32:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:32:57 INFO - Fetch https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:32:58 INFO - Http code: 200 09:32:58 INFO - Content-Encoding: None 09:32:58 INFO - Content-Type: application/zip 09:32:58 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:32:58 INFO - x-amz-cf-id: HPQDv3mTt1MNikgRWA7i9pP0Lu54a-jSPju5HU0QbnBfSfdsO69KmQ== 09:32:58 INFO - x-amz-version-id: nuF7ZH2Nkhqg9PRdlnS_MG20MR0AJTyO 09:32:58 INFO - x-cache: Hit from cloudfront 09:32:58 INFO - Expected file size: 14414067 09:32:58 INFO - Obtained file size: 14414067 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:58 INFO - trying https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:32:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:32:59 INFO - Downloaded 59739965 bytes. 09:32:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:32:59 INFO - mkdir: /builds/slave/test/properties 09:32:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:59 INFO - Contents: 09:32:59 INFO - build_url:https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:33:00 INFO - Running post-action listener: _resource_record_post_action 09:33:00 INFO - Running post-action listener: set_extra_try_arguments 09:33:00 INFO - [mozharness: 2016-09-29 16:33:00.529945Z] Finished download-and-extract step (success) 09:33:00 INFO - [mozharness: 2016-09-29 16:33:00.530171Z] Running populate-webroot step. 09:33:00 INFO - Running pre-action listener: _resource_record_pre_action 09:33:00 INFO - Running main action method: populate_webroot 09:33:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:00 INFO - '--tppagecycles', 09:33:00 INFO - '7'], 09:33:00 INFO - 'tests': ['tsvgm']}}, 09:33:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['damp', 'tps']}, 09:33:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'tests': ['damp', 'tps']}, 09:33:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['dromaeo_dom']}, 09:33:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['basic_compositor_video']}, 09:33:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['a11yr', 09:33:00 INFO - 'ts_paint', 09:33:00 INFO - 'tpaint', 09:33:00 INFO - 'sessionrestore', 09:33:00 INFO - 'sessionrestore_no_auto_restore', 09:33:00 INFO - 'tabpaint']}, 09:33:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['tsvgx', 09:33:00 INFO - 'tsvgr_opacity', 09:33:00 INFO - 'tart', 09:33:00 INFO - 'tscrollx', 09:33:00 INFO - 'cart']}, 09:33:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:00 INFO - 'tsvgr_opacity', 09:33:00 INFO - 'tart', 09:33:00 INFO - 'tscrollx', 09:33:00 INFO - 'cart']}, 09:33:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'talos_options': ['--disable-e10s'], 09:33:00 INFO - 'tests': ['tp5o']}, 09:33:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'tests': ['tp5o']}, 09:33:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'talos_options': ['--disable-e10s', 09:33:00 INFO - '--xperf_path', 09:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:00 INFO - 'tests': ['tp5n']}, 09:33:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:00 INFO - 'talos_options': ['--xperf_path', 09:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:00 INFO - 'tests': ['tp5n']}}, 09:33:00 INFO - 'talos.zip': {'path': '', 09:33:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:00 INFO - Running post-action listener: _resource_record_post_action 09:33:00 INFO - [mozharness: 2016-09-29 16:33:00.545659Z] Finished populate-webroot step (success) 09:33:00 INFO - [mozharness: 2016-09-29 16:33:00.545747Z] Running create-virtualenv step. 09:33:00 INFO - Running pre-action listener: _resource_record_pre_action 09:33:00 INFO - Running main action method: create_virtualenv 09:33:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:33:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:00 INFO - Using real prefix '/usr' 09:33:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:03 INFO - Installing pip.................done. 09:33:03 INFO - Return code: 0 09:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:03 INFO - Reading from file tmpfile_stdout 09:33:03 INFO - Output received: 09:33:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:33:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:03 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:03 INFO - Using env: {'DISPLAY': ':0', 09:33:03 INFO - 'HOME': '/home/cltbld', 09:33:03 INFO - 'LANG': 'en_US.UTF-8', 09:33:03 INFO - 'LANGUAGE': 'en_US:en', 09:33:03 INFO - 'LOGNAME': 'cltbld', 09:33:03 INFO - 'MAIL': '/var/mail/cltbld', 09:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:03 INFO - 'MOZ_NO_REMOTE': '1', 09:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:03 INFO - 'NO_EM_RESTART': '1', 09:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:03 INFO - 'PWD': '/builds/slave/test', 09:33:03 INFO - 'SHELL': '/bin/bash', 09:33:03 INFO - 'SHLVL': '1', 09:33:03 INFO - 'TERM': 'linux', 09:33:03 INFO - 'TMOUT': '86400', 09:33:03 INFO - 'USER': 'cltbld', 09:33:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:03 INFO - '_': '/tools/buildbot/bin/python'} 09:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:33:03 INFO - Cleaning up... 09:33:03 INFO - Return code: 0 09:33:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:03 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:33:03 INFO - Using env: {'DISPLAY': ':0', 09:33:03 INFO - 'HOME': '/home/cltbld', 09:33:03 INFO - 'LANG': 'en_US.UTF-8', 09:33:03 INFO - 'LANGUAGE': 'en_US:en', 09:33:03 INFO - 'LOGNAME': 'cltbld', 09:33:03 INFO - 'MAIL': '/var/mail/cltbld', 09:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:03 INFO - 'MOZ_NO_REMOTE': '1', 09:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:03 INFO - 'NO_EM_RESTART': '1', 09:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:03 INFO - 'PWD': '/builds/slave/test', 09:33:03 INFO - 'SHELL': '/bin/bash', 09:33:03 INFO - 'SHLVL': '1', 09:33:03 INFO - 'TERM': 'linux', 09:33:03 INFO - 'TMOUT': '86400', 09:33:03 INFO - 'USER': 'cltbld', 09:33:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:03 INFO - '_': '/tools/buildbot/bin/python'} 09:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:03 INFO - Downloading/unpacking psutil>=3.1.1 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:05 INFO - Installing collected packages: psutil 09:33:05 INFO - Running setup.py install for psutil 09:33:05 INFO - building 'psutil._psutil_linux' extension 09:33:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:33:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:33:06 INFO - building 'psutil._psutil_posix' extension 09:33:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:33:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:33:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:06 INFO - Successfully installed psutil 09:33:06 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:33:06 INFO - Using env: {'DISPLAY': ':0', 09:33:06 INFO - 'HOME': '/home/cltbld', 09:33:06 INFO - 'LANG': 'en_US.UTF-8', 09:33:06 INFO - 'LANGUAGE': 'en_US:en', 09:33:06 INFO - 'LOGNAME': 'cltbld', 09:33:06 INFO - 'MAIL': '/var/mail/cltbld', 09:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:06 INFO - 'MOZ_NO_REMOTE': '1', 09:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:06 INFO - 'NO_EM_RESTART': '1', 09:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:06 INFO - 'PWD': '/builds/slave/test', 09:33:06 INFO - 'SHELL': '/bin/bash', 09:33:06 INFO - 'SHLVL': '1', 09:33:06 INFO - 'TERM': 'linux', 09:33:06 INFO - 'TMOUT': '86400', 09:33:06 INFO - 'USER': 'cltbld', 09:33:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:06 INFO - '_': '/tools/buildbot/bin/python'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:08 INFO - Installing collected packages: mozsystemmonitor 09:33:08 INFO - Running setup.py install for mozsystemmonitor 09:33:08 INFO - Successfully installed mozsystemmonitor 09:33:08 INFO - Cleaning up... 09:33:08 INFO - Return code: 0 09:33:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:08 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:33:08 INFO - Using env: {'DISPLAY': ':0', 09:33:08 INFO - 'HOME': '/home/cltbld', 09:33:08 INFO - 'LANG': 'en_US.UTF-8', 09:33:08 INFO - 'LANGUAGE': 'en_US:en', 09:33:08 INFO - 'LOGNAME': 'cltbld', 09:33:08 INFO - 'MAIL': '/var/mail/cltbld', 09:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:08 INFO - 'MOZ_NO_REMOTE': '1', 09:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:08 INFO - 'NO_EM_RESTART': '1', 09:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:08 INFO - 'PWD': '/builds/slave/test', 09:33:08 INFO - 'SHELL': '/bin/bash', 09:33:08 INFO - 'SHLVL': '1', 09:33:08 INFO - 'TERM': 'linux', 09:33:08 INFO - 'TMOUT': '86400', 09:33:08 INFO - 'USER': 'cltbld', 09:33:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:08 INFO - '_': '/tools/buildbot/bin/python'} 09:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:10 INFO - warning: no files found matching '*.txt' 09:33:10 INFO - no previously-included directories found matching 'build' 09:33:10 INFO - no previously-included directories found matching 'dist' 09:33:10 INFO - no previously-included directories found matching '.git*' 09:33:11 INFO - Installing collected packages: jsonschema, functools32 09:33:11 INFO - Running setup.py install for functools32 09:33:11 INFO - warning: no files found matching '*.txt' 09:33:11 INFO - no previously-included directories found matching 'build' 09:33:11 INFO - no previously-included directories found matching 'dist' 09:33:11 INFO - no previously-included directories found matching '.git*' 09:33:11 INFO - Successfully installed jsonschema functools32 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:11 INFO - Using env: {'DISPLAY': ':0', 09:33:11 INFO - 'HOME': '/home/cltbld', 09:33:11 INFO - 'LANG': 'en_US.UTF-8', 09:33:11 INFO - 'LANGUAGE': 'en_US:en', 09:33:11 INFO - 'LOGNAME': 'cltbld', 09:33:11 INFO - 'MAIL': '/var/mail/cltbld', 09:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:11 INFO - 'MOZ_NO_REMOTE': '1', 09:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:11 INFO - 'NO_EM_RESTART': '1', 09:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:11 INFO - 'PWD': '/builds/slave/test', 09:33:11 INFO - 'SHELL': '/bin/bash', 09:33:11 INFO - 'SHLVL': '1', 09:33:11 INFO - 'TERM': 'linux', 09:33:11 INFO - 'TMOUT': '86400', 09:33:11 INFO - 'USER': 'cltbld', 09:33:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:11 INFO - '_': '/tools/buildbot/bin/python'} 09:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:11 INFO - Using env: {'DISPLAY': ':0', 09:33:11 INFO - 'HOME': '/home/cltbld', 09:33:11 INFO - 'LANG': 'en_US.UTF-8', 09:33:11 INFO - 'LANGUAGE': 'en_US:en', 09:33:11 INFO - 'LOGNAME': 'cltbld', 09:33:11 INFO - 'MAIL': '/var/mail/cltbld', 09:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:11 INFO - 'MOZ_NO_REMOTE': '1', 09:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:11 INFO - 'NO_EM_RESTART': '1', 09:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:11 INFO - 'PWD': '/builds/slave/test', 09:33:11 INFO - 'SHELL': '/bin/bash', 09:33:11 INFO - 'SHLVL': '1', 09:33:11 INFO - 'TERM': 'linux', 09:33:11 INFO - 'TMOUT': '86400', 09:33:11 INFO - 'USER': 'cltbld', 09:33:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:11 INFO - '_': '/tools/buildbot/bin/python'} 09:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:14 INFO - Downloading docopt-0.6.1.tar.gz 09:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:14 INFO - Running setup.py install for blobuploader 09:33:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:14 INFO - Running setup.py install for requests 09:33:14 INFO - Running setup.py install for docopt 09:33:14 INFO - Successfully installed blobuploader requests docopt 09:33:14 INFO - Cleaning up... 09:33:14 INFO - Return code: 0 09:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:14 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:14 INFO - Using env: {'DISPLAY': ':0', 09:33:14 INFO - 'HOME': '/home/cltbld', 09:33:14 INFO - 'LANG': 'en_US.UTF-8', 09:33:14 INFO - 'LANGUAGE': 'en_US:en', 09:33:14 INFO - 'LOGNAME': 'cltbld', 09:33:14 INFO - 'MAIL': '/var/mail/cltbld', 09:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:14 INFO - 'MOZ_NO_REMOTE': '1', 09:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:14 INFO - 'NO_EM_RESTART': '1', 09:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:14 INFO - 'PWD': '/builds/slave/test', 09:33:14 INFO - 'SHELL': '/bin/bash', 09:33:14 INFO - 'SHLVL': '1', 09:33:14 INFO - 'TERM': 'linux', 09:33:14 INFO - 'TMOUT': '86400', 09:33:14 INFO - 'USER': 'cltbld', 09:33:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:14 INFO - '_': '/tools/buildbot/bin/python'} 09:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:15 INFO - Running setup.py (path:/tmp/pip-E1P9S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:15 INFO - Running setup.py (path:/tmp/pip-0nSIoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:15 INFO - Running setup.py (path:/tmp/pip-QqVYUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:15 INFO - Running setup.py (path:/tmp/pip-xWa0p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:15 INFO - Running setup.py (path:/tmp/pip-GLuECC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:15 INFO - Running setup.py (path:/tmp/pip-oa6v3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:15 INFO - Running setup.py (path:/tmp/pip-hK4jgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:15 INFO - Running setup.py (path:/tmp/pip-Qa0OKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:15 INFO - Running setup.py (path:/tmp/pip-jGi11k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:15 INFO - Running setup.py (path:/tmp/pip-7gtsLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:15 INFO - Running setup.py (path:/tmp/pip-iWSTjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:15 INFO - Running setup.py (path:/tmp/pip-REsR2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:16 INFO - Running setup.py (path:/tmp/pip-EPUIOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:16 INFO - Running setup.py (path:/tmp/pip-CNVoVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:16 INFO - Running setup.py (path:/tmp/pip-fJWEsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:16 INFO - Running setup.py (path:/tmp/pip-dwk9zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:16 INFO - Running setup.py (path:/tmp/pip-GIRgRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:16 INFO - Running setup.py install for manifestparser 09:33:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:16 INFO - Running setup.py install for mozcrash 09:33:16 INFO - Running setup.py install for mozdebug 09:33:16 INFO - Running setup.py install for mozdevice 09:33:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:16 INFO - Running setup.py install for mozfile 09:33:16 INFO - Running setup.py install for mozhttpd 09:33:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozinfo 09:33:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozInstall 09:33:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozleak 09:33:17 INFO - Running setup.py install for mozlog 09:33:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for moznetwork 09:33:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozprocess 09:33:17 INFO - Running setup.py install for mozprofile 09:33:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozrunner 09:33:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:17 INFO - Running setup.py install for mozscreenshot 09:33:17 INFO - Running setup.py install for moztest 09:33:18 INFO - Running setup.py install for mozversion 09:33:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:18 INFO - Cleaning up... 09:33:18 INFO - Return code: 0 09:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:18 INFO - Using env: {'DISPLAY': ':0', 09:33:18 INFO - 'HOME': '/home/cltbld', 09:33:18 INFO - 'LANG': 'en_US.UTF-8', 09:33:18 INFO - 'LANGUAGE': 'en_US:en', 09:33:18 INFO - 'LOGNAME': 'cltbld', 09:33:18 INFO - 'MAIL': '/var/mail/cltbld', 09:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:18 INFO - 'MOZ_NO_REMOTE': '1', 09:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:18 INFO - 'NO_EM_RESTART': '1', 09:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:18 INFO - 'PWD': '/builds/slave/test', 09:33:18 INFO - 'SHELL': '/bin/bash', 09:33:18 INFO - 'SHLVL': '1', 09:33:18 INFO - 'TERM': 'linux', 09:33:18 INFO - 'TMOUT': '86400', 09:33:18 INFO - 'USER': 'cltbld', 09:33:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:18 INFO - '_': '/tools/buildbot/bin/python'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:18 INFO - Running setup.py (path:/tmp/pip-CtXkbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:18 INFO - Running setup.py (path:/tmp/pip-XnChT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:18 INFO - Running setup.py (path:/tmp/pip-NbI1VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:18 INFO - Running setup.py (path:/tmp/pip-BbTcfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:18 INFO - Running setup.py (path:/tmp/pip-TJel09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:18 INFO - Running setup.py (path:/tmp/pip-m_sW31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:18 INFO - Running setup.py (path:/tmp/pip-TNJTs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:18 INFO - Running setup.py (path:/tmp/pip-6EiNkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:19 INFO - Running setup.py (path:/tmp/pip-7axuTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:19 INFO - Running setup.py (path:/tmp/pip-Ji0YeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:19 INFO - Running setup.py (path:/tmp/pip-k_Ka9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:19 INFO - Running setup.py (path:/tmp/pip-IPl29t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:19 INFO - Running setup.py (path:/tmp/pip-IWGBgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:19 INFO - Running setup.py (path:/tmp/pip-lpyol1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:19 INFO - Running setup.py (path:/tmp/pip-sD47Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:19 INFO - Running setup.py (path:/tmp/pip-JG8PQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:19 INFO - Running setup.py (path:/tmp/pip-AVLAjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:21 INFO - Downloading blessings-1.6.tar.gz 09:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:21 INFO - Installing collected packages: blessings 09:33:21 INFO - Running setup.py install for blessings 09:33:21 INFO - Successfully installed blessings 09:33:21 INFO - Cleaning up... 09:33:21 INFO - Return code: 0 09:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:22 INFO - Reading from file tmpfile_stdout 09:33:22 INFO - Current package versions: 09:33:22 INFO - argparse == 1.2.1 09:33:22 INFO - blessings == 1.6 09:33:22 INFO - blobuploader == 1.2.4 09:33:22 INFO - docopt == 0.6.1 09:33:22 INFO - functools32 == 3.2.3-2 09:33:22 INFO - jsonschema == 2.5.1 09:33:22 INFO - manifestparser == 1.1 09:33:22 INFO - mozInstall == 1.12 09:33:22 INFO - mozcrash == 0.17 09:33:22 INFO - mozdebug == 0.1 09:33:22 INFO - mozdevice == 0.48 09:33:22 INFO - mozfile == 1.2 09:33:22 INFO - mozhttpd == 0.7 09:33:22 INFO - mozinfo == 0.9 09:33:22 INFO - mozleak == 0.1 09:33:22 INFO - mozlog == 3.4 09:33:22 INFO - moznetwork == 0.27 09:33:22 INFO - mozprocess == 0.23 09:33:22 INFO - mozprofile == 0.28 09:33:22 INFO - mozrunner == 6.12 09:33:22 INFO - mozscreenshot == 0.1 09:33:22 INFO - mozsystemmonitor == 0.3 09:33:22 INFO - moztest == 0.7 09:33:22 INFO - mozversion == 1.4 09:33:22 INFO - psutil == 3.1.1 09:33:22 INFO - requests == 1.2.3 09:33:22 INFO - wsgiref == 0.1.2 09:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:22 INFO - Using env: {'DISPLAY': ':0', 09:33:22 INFO - 'HOME': '/home/cltbld', 09:33:22 INFO - 'LANG': 'en_US.UTF-8', 09:33:22 INFO - 'LANGUAGE': 'en_US:en', 09:33:22 INFO - 'LOGNAME': 'cltbld', 09:33:22 INFO - 'MAIL': '/var/mail/cltbld', 09:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:22 INFO - 'MOZ_NO_REMOTE': '1', 09:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:22 INFO - 'NO_EM_RESTART': '1', 09:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:22 INFO - 'PWD': '/builds/slave/test', 09:33:22 INFO - 'SHELL': '/bin/bash', 09:33:22 INFO - 'SHLVL': '1', 09:33:22 INFO - 'TERM': 'linux', 09:33:22 INFO - 'TMOUT': '86400', 09:33:22 INFO - 'USER': 'cltbld', 09:33:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:22 INFO - '_': '/tools/buildbot/bin/python'} 09:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:33:22 INFO - Cleaning up... 09:33:22 INFO - Return code: 0 09:33:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 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 0x7f0c49ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:33:22 INFO - Using env: {'DISPLAY': ':0', 09:33:22 INFO - 'HOME': '/home/cltbld', 09:33:22 INFO - 'LANG': 'en_US.UTF-8', 09:33:22 INFO - 'LANGUAGE': 'en_US:en', 09:33:22 INFO - 'LOGNAME': 'cltbld', 09:33:22 INFO - 'MAIL': '/var/mail/cltbld', 09:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:22 INFO - 'MOZ_NO_REMOTE': '1', 09:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:22 INFO - 'NO_EM_RESTART': '1', 09:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:22 INFO - 'PWD': '/builds/slave/test', 09:33:22 INFO - 'SHELL': '/bin/bash', 09:33:22 INFO - 'SHLVL': '1', 09:33:22 INFO - 'TERM': 'linux', 09:33:22 INFO - 'TMOUT': '86400', 09:33:22 INFO - 'USER': 'cltbld', 09:33:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:22 INFO - '_': '/tools/buildbot/bin/python'} 09:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:22 INFO - Cleaning up... 09:33:22 INFO - Return code: 0 09:33:22 INFO - Running post-action listener: _resource_record_post_action 09:33:22 INFO - Running post-action listener: _start_resource_monitoring 09:33:22 INFO - Starting resource monitoring. 09:33:22 INFO - [mozharness: 2016-09-29 16:33:22.522285Z] Finished create-virtualenv step (success) 09:33:22 INFO - [mozharness: 2016-09-29 16:33:22.522802Z] Running install step. 09:33:22 INFO - Running pre-action listener: _resource_record_pre_action 09:33:22 INFO - Running main action method: install 09:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:22 INFO - Reading from file tmpfile_stdout 09:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:22 INFO - Reading from file tmpfile_stdout 09:33:22 INFO - Output received: 09:33:22 INFO - Usage: mozinstall [options] installer 09:33:22 INFO - Options: 09:33:22 INFO - -h, --help show this help message and exit 09:33:22 INFO - -d DEST, --destination=DEST 09:33:22 INFO - Directory to install application into. [default: 09:33:22 INFO - "/builds/slave/test"] 09:33:22 INFO - --app=APP Application being installed. [default: firefox] 09:33:22 INFO - mkdir: /builds/slave/test/build/application 09:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:39 INFO - Reading from file tmpfile_stdout 09:33:39 INFO - Output received: 09:33:39 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:39 INFO - Running post-action listener: _resource_record_post_action 09:33:39 INFO - [mozharness: 2016-09-29 16:33:39.826365Z] Finished install step (success) 09:33:39 INFO - [mozharness: 2016-09-29 16:33:39.826611Z] Running run-tests step. 09:33:39 INFO - Running pre-action listener: _resource_record_pre_action 09:33:39 INFO - Running main action method: run_tests 09:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:39 INFO - Python 2.7.3 09:33:39 INFO - Return code: 0 09:33:39 INFO - grabbing minidump binary from tooltool 09:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:39 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 0xcdc930>, '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 0xcdd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcddcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:33:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:33:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:33:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:39 INFO - Return code: 0 09:33:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:39 INFO - Using env: {'DISPLAY': ':0', 09:33:39 INFO - 'HOME': '/home/cltbld', 09:33:39 INFO - 'LANG': 'en_US.UTF-8', 09:33:39 INFO - 'LANGUAGE': 'en_US:en', 09:33:39 INFO - 'LOGNAME': 'cltbld', 09:33:39 INFO - 'MAIL': '/var/mail/cltbld', 09:33:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:39 INFO - 'MOZ_NO_REMOTE': '1', 09:33:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:39 INFO - 'NO_EM_RESTART': '1', 09:33:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:39 INFO - 'PWD': '/builds/slave/test', 09:33:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:39 INFO - 'SHELL': '/bin/bash', 09:33:39 INFO - 'SHLVL': '1', 09:33:39 INFO - 'TERM': 'linux', 09:33:39 INFO - 'TMOUT': '86400', 09:33:39 INFO - 'USER': 'cltbld', 09:33:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141', 09:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:39 INFO - '_': '/tools/buildbot/bin/python'} 09:33:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:40 INFO - mozversion application_buildid: 20160929063004 09:33:40 INFO - mozversion application_changeset: 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 09:33:40 INFO - mozversion application_display_name: Nightly 09:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:40 INFO - mozversion application_name: Firefox 09:33:40 INFO - mozversion application_remotingname: firefox 09:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:33:40 INFO - mozversion application_vendor: Mozilla 09:33:40 INFO - mozversion application_version: 52.0a1 09:33:40 INFO - mozversion platform_buildid: 20160929063004 09:33:40 INFO - mozversion platform_changeset: 215adbcb1987f3a8e065f4c92a3d4215d3f93dd1 09:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:33:40 INFO - mozversion platform_version: 52.0a1 09:33:40 INFO - using testdate: 1475166820 09:33:40 INFO - actual date: 1475166820 09:33:40 INFO - starting webserver on 'localhost:44226' 09:33:40 INFO - SUITE-START | Running 2 tests 09:33:40 INFO - TEST-START | dromaeo_css 09:33:40 INFO - operating with platform_type : linux_ 09:33:40 INFO - Initialising browser for dromaeo_css test... 09:33:40 INFO - TEST-INFO | started process 25734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6l4Dz/profile http://localhost:44226/getInfo.html) 09:33:44 INFO - PROCESS | 25734 | __metrics Screen width/height:1600/1200 09:33:44 INFO - PROCESS | 25734 | colorDepth:24 09:33:44 INFO - PROCESS | 25734 | Browser inner width/height: 1024/697 09:33:44 INFO - PROCESS | 25734 | __metrics 09:33:45 ERROR - PROCESS | 25734 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 09:33:46 INFO - TEST-INFO | 25734: exit 0 09:33:46 INFO - Browser initialized. 09:33:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:46 INFO - TEST-INFO | started process 25856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6l4Dz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:58 INFO - PROCESS | 25856 | RSS: Main: 185466880 09:33:58 INFO - PROCESS | 25856 | 09:34:48 INFO - PROCESS | 25856 | 1475166888079 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:36:57 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44226/tests/dromaeo/cssquery-ext.html) 09:36:59 INFO - PROCESS | 25856 | RSS: Main: 199999488 09:36:59 INFO - PROCESS | 25856 | 09:40:01 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-ext.html (next: http://localhost:44226/tests/dromaeo/cssquery-jquery.html) 09:40:01 INFO - PROCESS | 25856 | RSS: Main: 197054464 09:40:01 INFO - PROCESS | 25856 | 09:43:03 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44226/tests/dromaeo/cssquery-mootools.html) 09:43:04 INFO - PROCESS | 25856 | RSS: Main: 199065600 09:43:04 INFO - PROCESS | 25856 | 09:46:06 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44226/tests/dromaeo/cssquery-prototype.html) 09:46:06 INFO - PROCESS | 25856 | RSS: Main: 195579904 09:46:06 INFO - PROCESS | 25856 | 09:49:09 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44226/tests/dromaeo/cssquery-yui.html) 09:49:09 INFO - PROCESS | 25856 | RSS: Main: 198930432 09:49:09 INFO - PROCESS | 25856 | 09:52:12 INFO - PROCESS | 25856 | Cycle 1(1): loaded http://localhost:44226/tests/dromaeo/cssquery-yui.html (next: http://localhost:44226/tests/dromaeo/cssquery-dojo.html) 09:52:13 INFO - PROCESS | 25856 | RSS: Main: 199294976 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | __start_tp_report 09:52:13 INFO - PROCESS | 25856 | _x_x_mozilla_page_load 09:52:13 INFO - PROCESS | 25856 | _x_x_mozilla_page_load_details 09:52:13 INFO - PROCESS | 25856 | |i|pagename|runs| 09:52:13 INFO - PROCESS | 25856 | |0;dojo.html;3064.233941514621;3083.306256092381;3101.736352410045;3116.937661246775;3118.064580625813;5361.544268737152;5404.891902161954;5482.122860342346;5499.395066542682;5499.917501237484;5388.0570900092525;5388.137897936331;5401.189821526773;5453.509184173424;5475.178723191523;4869;4974.253861920704;5012.273220383042;5039.697618142924;5057.190849464087;4998.250262460624;5005.879055183727;5050.924236136461;5058.165402708549;5059.949400506003;4857.854264372075;4875.731834749087;4922.507749225085;4951.009798040406;5011.348524691785;4981.9252711209365;4997.30037794709;4997.675151115202;5052.242163675478;5053.343065401511;4918.213085906238;4959.008198360342;4962.379702537183;4966.776495057731;5037.748112594356;5206.0368831766245;5281.70950597717;5325.653832500914;5393.433689462589;5455.208994695787;5716.371199168088;5796.97101514494;5801.390853960358;5864.5894787364905;5866.882662346729;5830.854228644275;5839.240898683144;5841.883162336772;5847.561432892508;5857.326407463153;5393.9730301348245;5402.297701298806;5407.45925407464;5410.269613602192;5441.428649991693;5846.795362162304;5857.765689372377;5908.025175846024;5952.9107063394085;6020.548458865603;5658.660480371191;5666.914996275059;5667.574931880125;5671.461211184931;5707.942920570824;5655.503963929006;5670.121131224667;5716.08542633185;5756.395578464285;5787.8553036174435;5702.942970570324;5753;5780.583756979567;5829.242198514251;5897.970510147507;5798.710064496759;5803.361630220672;5805.10020946754;5807.68057756819;5845.152452894306;4390.319500477431;4425.269830477935;4435.889102772392;4444.977775111104;4501.752403617833;3931.4692516509904;3970.0471886746973;4007.6593489553716;4040.1717647882115;4109.198706252312;5581.804636837691;5592.356878958972;5602.1036634138345;5605.215269862222;5609;5898.941010589925;5941.079132734347;5941.138534912414;5944.940550594439;5954.46409823118;5318.175682769177;5435.537979271727;5452.318460192476;5510.228568000483;5517.475839795213;4917.557419832161;4930.975345123323;4937.284093806378;4939.604831613462;4968.503149685002;6088.908666370008;6103.969480152659;6108.717846559889;6109.95128740435;6110.528382738247;5777.971110144591;5826.271716035496;5873.882522349443;5905.822825315247;5959.28488581373;6077.35626103157;6132.508481341157;6141.345899189975;6143.603994442082;6145.678679084019;5809.680467574324;5816.73824677882;5827.184194212899;5844.12338149281;5851.093080572518;5755.3381361144;5797.159411885169;5804.970975145097;5865.530757539302;5955.821325360246;5759.539236861125;5770.076787714113;5783.624064435799;5784.305883294031;5789.2763404574425;5689.345725241485;5716.485516303553;5750.223719797774;5784.971075144766;5848.736806843787;5614.747336369792;5628.352739435018;5643;5705.800296989585;5761.395053519488;5818.0981947798155;5823.767049317979;5823.912641310299;5835.533157347487;5854.677992710272;5524.088525393265;5578.916316255179;5624.100143976944;5691.544676425959;5694.060480020916 09:52:13 INFO - PROCESS | 25856 | |1;ext.html;571.9885602287952;574.2161948939697;589.307563612755;592.1857446011734;593.237689568904;42796.35805462921;44711.77644111783;44764.32853507196;47849.760751196285;48164.51835481644;44439.77780111103;44702;44845.7757711211;45059.77470112645;45300.54699453004;8906.242969347613;9079.455232686027;9080.318976076787;9088.045755195708;9090;8925.152110549487;8986.505742184178;9014.233790127848;9019.188273055424;9021.548922553879;9070.183683468487;9111.27109831212;9111.45331280122;9112.635494580209;9117.179453849152;8928.330375221884;8982.685606003759;8993.325500587449;9024.503652299089;9050.954745226265;8884.555772211364;8898.555072246361;8940.061293564147;8967.730968070968;8977.461352318882;43460.78269608664;43811;43890.12219755587;43947.78026109849;44004.11991760179;3412.1640198151363;3472.687458128755;3475.5134281200653;3668.0646435158865;3837.3668344723087;32695.50956735651;33276.33447331064;33532.49701254483;33616.32767344664;33823.830880845686;3668.1196512836996;3744.120131769032;3795.8481660733537;3805.8858234253016;3829.9617003829885;374376;374660;375526;376215;376509;60928.08607870885;61074.38925610776;61561;61575;61636;36586.63413365885;37355.25289494195;37502.24995500075;64514.77426128769;64613;15002;15028.323725432381;15085.773713394308;15120.924395377953;15146.394144234328;10832.187585931088;10947.124230061576;10992.835107473395;10995.285306455055;11016.614418495474;18837.529061773566;18847.62304753897;19045.238190472224;19107.426777196706;19116.470682345378;6908.723651053901;7106.786796396116;7139;7185.568865868065;7205.819854503679;964.3105179796479;1018.7198520406947;1061.4321338084087;1061.7080302916759;1077.9730506737394;32129.839350803097;32758.344833103205;33078.17304567405;33258.168545786066;33715.83142084323;893.4014210478995;1076.4079756134095;1141.1270378160714;1160.4197901049474;1193.1349771415655;17167.227474763666;17333.653326933392;17453.476395707894;17455.476335709947;17529.12354382276;555690;942610;947003;953931;955266;59406;60092.39907600868;60181;60271.69864150651;60305.09542356868;1341.081359268904;1356.6269275949194;1368.6167872995577;1386.0713322074234;1386.6394737368357;31146.37707245797;33666.326673465905;33778.32443351168;34092.65907340895;34404.48393274153;52501.7374913123;53298.73350633222;53343.73328133334;53376.73311633417;53449.465505346;514727;516303;517955;520810;522998;28632.427351453272;28693.856530717214;28986.275343115747;29231.85384073066;29340.413191736472;47871;48907.26639100487;49462.75268623634;49888;50024.74987625039;40014.39978400384;40553;40646.59353406428;43074.353884691125;45456;39955.40066899057;43201;44484.555154449336;45239.00783003903;46158;42667;42706.572934271506;42773.786131069144;43211.56788432076;43321;32505.837470812494;36612.81693591515;37925.24149516939;38283.425748613234;38405.6159438402;28302;28319.298822895682;28625;29070.27324316909;29232.707672923 09:52:13 INFO - PROCESS | 25856 | |2;jquery.html;404.35909084101695;405.36965019394836;405.8112977465478;416.09499338937815;429.13957515182057;15412.537623871274;17783.911080444614;18526.536836579093;19370.418887433363;19400.90299548502;17542.64914701705;17778.46664600064;18198.545036374097;18479.07604619767;18559.536011599717;5755.942440575593;5767.529280033586;5778.104393818965;5807.854803629901;5838.824835254928;5759.078547432412;5855.824325270249;5861.941380586182;5865.208196893429;5866.677332746697;5659.9058348411145;5748.942510574903;5777.45114214149;5796.884062318751;5797.971010144944;5589.944100558983;5751.10857817037;5816.912746308788;5820.621659592113;5835.883282334372;5109.642325037249;5201.037808005531;5205.687658740488;5213.556847667953;5214.530692237717;22966.54066918669;23651.172208972603;23662.881685591634;23687;23711.644325335135;2401.1355911871888;2429.9514009719883;2491.763282488179;2515.3963048868322;3054.648715397713;14901.92549037248;14903.850961490463;14960.700785984329;15038;15636.687266254612;1918.386116442739;1924.288013435038;1925.7015162649811;1940.805919408062;1955.5404479947201;80241.59879200567;81817.59091204565;82310;82971;84589;10408.449929767105;10505.26863015606;10626.574937002588;10739.892601073889;10898.278403838049;13430.529931452353;15379.385164557783;15549.144797036271;15552.455664051704;15580.831437642222;7052.753153639598;7834.882476762853;7851.136374998746;7875.684972601031;8179.100298967109;7358.8528229435115;7396.630168491554;7463.7532673286205;7657.349125324298;7695.038120234971;6568.901466478007;6666.933330666729;6709.865802684017;6833.384995350442;6872.244053154149;1942.4464027752306;1962.823345898876;1965.1942703491786;2009.6081264153643;2009.728686627316;925.5973651461636;929.330881765128;939.0468674295458;959.7072892767633;1027.209049032241;18842.963637000095;20606.484837879172;20726.58546829055;20726.792732072485;20960.37118886436;969.8496733006396;1018.4144117132678;1034.8395998620076;1084.360227465799;1120.6469961961957;10763.24657273999;11629.651110466699;11672.358020308795;11810.822837657443;11833.112516561292;451444;452314;458470;461460;462633;84213.57893210495;84791;84907;85321;86021.13978860257;984.1192133041031;1016.3038318751679;1033.9534720937577;1046.0115191144296;1048.124815778818;17356.218970146627;17516.525963683027;17920;18138.72791908096;18205.726914096034;37679.62320376761;38818.41772373473;39516;39663.80168099256;41138.58861411468;50992.74503627458;51012.48987510077;51274;52893.20660190177;53875.61243875738;8587.141285871363;8730.869036964323;8938.553072346487;9050.140236677506;9077.546122693971;12636.2418254905;12818.935905320413;12888.548900788428;13256;13273.269970151734;11367.658970230907;11411.486483108114;11568.305901645928;11750.11874109428;12310.199837010565;11160.609378672032;11438.94280528592;11513.194076414571;11620.825687614863;11744.354060526754;11177.832332515181;11452.427378631202;11625.941870290595;11776.70558236051;12194;8508.659653613786;8732.78168045804;8748.606312715816;8783.780405489913;9014.909850901407;5508.55931525469;5625.718714064198;5871.035127260706;10913.635795525559;11427.771444570895 09:52:13 INFO - PROCESS | 25856 | |3;mootools.html;1424.2807382271953;1453.8473460286668;1567.6942996115754;1637.9181040947965;1709.4187976088128;7622.923770762291;7914.80212994674;8143.755687329382;8869.246114080303;8907.46555206688;8163.469374490669;8541.060483346826;8595.140485951402;8766.34252431067;8833.293336533077;2312.2022902098747;2339.368370539953;2342.2387723989686;2342.7188737351544;2363.6927199464044;2265.8527195732227;2315.548468048731;2316.791488766011;2317.571249318881;2321.4446320964907;2286.142696488817;2304.562133194696;2318.420394901275;2337.801286890616;2338.403707054707;2205.44863784054;2248.6627005949076;2250.8987095580655;2253.5943530164564;2271.977280227193;2218.556288742258;2227.3429338345227;2230.364346161336;2231.3752149398197;2233.5197932444603;8844.159804818531;8925.107489251088;8930;8942.239909607692;8959.596818143134;4882.829100981484;4913.680610760289;5017.096922553938;5045.621578381636;5068.594512438996;3226.5644138041534;3289.687479689426;3418.6581341865863;3438.1404648837793;3444.1389652586854;1101.6529793115144;1126.707056165403;1134.9773004539945;1150.896419322265;1155.185594156118;11531.769364612745;11640.301581905029;11677.70805729855;11705.70735731605;11786.941065294619;4295.463067116611;4435.290353543418;4534.161180181611;4595.747233902101;4609.308603709471;9931.553080111413;9942.751431214278;9980.850287245697;9999.550020249106;10011.549480273405;4962.8759281018265;4963.801447942042;5010.949890501049;5015.699058056528;5019.648624596316;4054.959450405458;4180.205760905418;4407.537208593116;4540.72755634663;4578.587927086578;3745.9250814983548;3855.9228815423535;3873.6707379872464;3884.8251828667776;3957.841686332572;1276.1959965221852;1286.4275397448046;1288.7809072457705;1292.3086148910477;1295.2811189789757;743.8177646476648;837.4556538250064;932.2076235200161;941.1858742188095;947.0292949726586;5719.656820590778;5814.3313518945015;6035.366286539938;6126.754929802758;6188.938110618837;927.8190752803139;932.8740620016347;938.3009657804979;983.306768728045;1012.964546240878;4153.418521407006;4277.272863613131;4279.358096285582;4304.569543045671;4317.330813723878;10504.264701470824;11029;11061.115110791117;11062.668119956414;11090.722731931604;10599.84100238497;10900.945495272474;10921.12630989519;10929.453527323602;10992.780144397067;7221.494495385377;7395.149557800814;7410.444216683771;7427.44294177928;7485.513441626277;5865.648061116347;5908.202392676933;6013.548983826143;6018.909716354171;6151.630902145886;9648.372855764354;9666.226701863694;9681.37071090377;9702.223822094356;9778.266630002636;9017.864732029157;9586.089321514444;9604.75988100303;9633.687914900514;9670.613175472903;6774.898376524455;7026.332498412643;7199.71201151948;7606.239376062349;7718.073831140299;8236.682130859033;8642.913570864212;8648.870266945874;8662.13378662154;8691.043985161754;7410.666520006721;7471.028766260351;7490.288422599844;7527.774166775005;7729.149793522821;7317.378022868116;7365.594892280762;7422.480426370318;7438.59087750179;7716.807079823049;7072.434205263464;7210.639468026683;7221.67502462401;7229.855402892018;7236.312550307713;5197.610179236648;5199.428062913152;5209.218617207449;5416.37711663148;5463.207834864002;5334.866628334167;5338.199270109515;5376;5379.865503362447;5476.288082549243 09:52:13 INFO - PROCESS | 25856 | |4;prototype.html;317.3684368107467;331.4415210370526;338.6342749830184;340.8819073439119;343.49334731271364;5386.192071189319;5523.226748255248;5551.306086739158;5566.332040155177;5578;5438.782448702057;5465.699386533739;5467.890642187154;5482.835514934548;5482.972585137079;4354.412154359168;4370.431843860294;4377.759223242729;4384.298512238027;4409.4708634963845;4305.849295274666;4336.653067754588;4355.978220108911;4379.474463064421;4412.75729834859;4271.231178387889;4314.180305741915;4323.5460276670965;4328.870133895988;4338.869833904988;4312.417823593822;4345.304751239786;4347.5217726050105;4363.847265345697;4369;3800.9592326138977;3836.8848934532007;3843.8846834595006;3902.439024390238;3919.862804801847;5291.232771248186;5311.468853114697;5332.280142180794;5345.572354211693;5385.838424847261;4930.630202734809;4957.256411538262;4964.801407943678;4969.856932905452;4994.55049045584;5474.808381706621;5672.319321681383;5733.856653583652;5761.395053519362;5768.394318596571;4132.421460995463;4149.97925010376;4159.771212583307;4183.769892655902;4196.895077623053;5766.913496297559;5978.103284507359;5996.640201587875;6004.819855404345;6020.518358531307;4180.540140584533;4197.790110494463;4199.349100889367;4218.810153543098;4222.303319952235;4238.449001629769;4286.978565107217;4288.206681763883;4289.957100429018;4292.763897985641;4639.605633521121;4899.191633380452;4908.435529914034;4916.139675556763;4929.359183306219;5725.541956643458;5754.482096611325;5767.22142510764;5771.922108041102;5801.158831969341;1476.8375478697335;1478.2608695652175;1488.1368806092441;1494.7160039592443;1499.6925630245773;892.9728221329698;944.8771659684335;953.0993211415284;953.2659851913987;975.492743773234;4868.78090485929;4887.29134275528;4898.2652602109965;4922.926156107661;4958.776855041532;5156.9742151289;5211.869703257449;5225.242339860699;5231.450697676689;5239.502247286502;4637.837675681335;4865.537773911473;4925.359703238556;4939.48135445773;4952.603791696655;2764.654418197725;2788.888444462199;2803.710293265121;2835.6030155778208;2838.5458326667635;5430.664814129883;5527.585431092603;5527.668339899619;5532.86167845799;5545.890821835568;5077.847664570068;5207.0366982108435;5230.593926793641;5284.497972692588;5396.784128634889;5346.973265133727;5363.436839131835;5376.758045887945;5393.763741754916;5508.614396992252;5213.478652134756;5220.634555581073;5224.66039707433;5250.816221432385;5251.921221181609;4977.502249775139;5004.2493625956395;5018.548330650259;5042.369703787027;5090.447413538906;5278.656887302467;5959.67221802805;6026.3126324629175;6105.572609917263;6106.603070800384;4256.829726811016;4360.716553424018;4371.054880578239;4391.516933137288;4400.141972315368;5722.595055941708;5916.763329466773;5939.881202376015;5973.462388384893;5998.160257563857;5684.261046063985;5700.743466543932;5702.8289151325525;5706.144078388275;5715.199872017838;5742.36833948257;5762.645778242194;5764.798232061858;5765.509931655856;5814.73833677494;5518.255035570147;5698.800541981011;5724.942750572608;5749.338826035059;5795.291013751287;5806.390329015392;5824.475797178275;5827.096799996008;5858.443447872445;5886.558508111994;5552.555795536428;5748.45389687979;5789.913151302818;5797.130430435468;5805.010419633808 09:52:13 INFO - PROCESS | 25856 | |5;yui.html;729.5330988167572;777.2111307023372;782.7573452229806;822.9588520573969;853.389826274214;15077;16383.672326553462;16393.91803040983;16400.917995410007;16460.259288332025;15387.615309617266;15559.611009724762;15564.844351556481;15566.143862087582;15602.375904963788;779.2052106851008;783.7844592737;807.4347956430493;810.2302812328282;819.3772732723114;808.6320724070563;813.0203105258179;814.6252723747053;816.1756625807947;816.7182322098867;848.4909054567272;849.4987957105307;851.595492141231;853.2406158518924;853.5007020892785;845.6744153500915;848.6520526584133;848.6775025490335;850.8596081646521;851.0213254757078;612.702839123025;619.761391864131;620.2247191011236;621.8196722950385;622.5019984012772;14695.63260918475;14718.411263549446;14792.334344954503;14871.776923346159;14909.254537273093;14642.70714585713;15035.377652079078;15056.548303550911;15068.623284417978;15171.924140379338;10402.5838966442;10447.216458765546;10730.570777168903;10755.354678719303;11084.224104312701;3734.775913445175;3801.4487899254455;3882.0683036071423;3956.4065390191413;3958.2875082485143;57180.14229786557;57602;58257.12614310789;58685;75299.99999999945;10517.84223236652;10748.408837514013;10754.838677419844;10872;10941.4529273536;21165;21269.149234030465;21440.463988400414;21453.463663408227;21459.46351341229;7703.768886933401;7984.441089123822;8275.54484503358;8444.282236009885;8444.408891377667;4502.774861256924;4720.33915251865;4745.264484004984;4772.856814295576;4878.609711223094;3287.6383597804224;3340.398728228942;3368.5789276340456;3380.983095084509;3383.3402486515383;571.5570432914525;592.1295695327861;593.6438137117781;602.4367216652444;615.3600255733986;706.5654622407183;715.9821004474929;729.5659082845698;734.097060615446;763.4083585221387;8727.781805454788;9212.447253164697;9255.35212535116;9359.221747867883;9434.622615095319;678.4402867634221;698.4272896225046;709.6522703875064;726.2882375272263;726.3620535692086;4316.309390497506;4502.909941801146;4544.545545445495;4587.587117159472;4634.675572709945;113859;120488;125220;125519;127682;80895.59552202202;84536.57731711425;107240.46379768207;110536.4473177629;110712;50195;60313;80288.59855700684;81697.59151204205;85045.57477212822;9581.664641737505;9825.840380995973;9956.55195516218;9993.800123997335;10014.575669538845;46316;48039.51960480351;48415.75792121017;49764.502354975986;50107.49892501028;70044;70169.29830701627;74654.62672686602;75555.62222188854;76484.23515764771;12848.229106253655;13076.738465230452;13142.34288285601;13312.400941957441;13429.597112086652;14781.05903786128;14948.476803311833;15608.375664973728;15680.451184208498;15701.685966280382;13077.291217994842;13213.603591892259;13957.162570245819;14235.35940882642;14973.32620032123;13410.195388276734;13728.313584320944;13837;13905.096168749;14396.280185990448;12958.611241662766;13677.24775137377;13805.17168969865;13844.100133491695;14333.56999290023;11134.220604557604;11447.484863181011;11459.942700286445;11823.70440738954;11882.16824822254;10503.061351993003;10788.352698838095;11218.214724969173;12201.14591978553;12324.815127772912 09:52:13 INFO - PROCESS | 25856 | __end_tp_report 09:52:13 INFO - PROCESS | 25856 | __start_cc_report 09:52:13 INFO - PROCESS | 25856 | _x_x_mozilla_cycle_collect,312 09:52:13 INFO - PROCESS | 25856 | __end_cc_report 09:52:13 INFO - PROCESS | 25856 | __startTimestamp1475167933178__endTimestamp 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | ------- Summary: start ------- 09:52:13 INFO - PROCESS | 25856 | Number of tests: 6 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#0] dojo.html Cycles:165 Average:5424.52 Median:5658.66 stddev:628.23 (11.1%) stddev-sans-first:602.25 09:52:13 INFO - PROCESS | 25856 | Values: 3064.2 3083.3 3101.7 3116.9 3118.1 5361.5 5404.9 5482.1 5499.4 5499.9 5388.1 5388.1 5401.2 5453.5 5475.2 4869.0 4974.3 5012.3 5039.7 5057.2 4998.3 5005.9 5050.9 5058.2 5059.9 4857.9 4875.7 4922.5 4951.0 5011.3 4981.9 4997.3 4997.7 5052.2 5053.3 4918.2 4959.0 4962.4 4966.8 5037.7 5206.0 5281.7 5325.7 5393.4 5455.2 5716.4 5797.0 5801.4 5864.6 5866.9 5830.9 5839.2 5841.9 5847.6 5857.3 5394.0 5402.3 5407.5 5410.3 5441.4 5846.8 5857.8 5908.0 5952.9 6020.5 5658.7 5666.9 5667.6 5671.5 5707.9 5655.5 5670.1 5716.1 5756.4 5787.9 5702.9 5753.0 5780.6 5829.2 5898.0 5798.7 5803.4 5805.1 5807.7 5845.2 4390.3 4425.3 4435.9 4445.0 4501.8 3931.5 3970.0 4007.7 4040.2 4109.2 5581.8 5592.4 5602.1 5605.2 5609.0 5898.9 5941.1 5941.1 5944.9 5954.5 5318.2 5435.5 5452.3 5510.2 5517.5 4917.6 4931.0 4937.3 4939.6 4968.5 6088.9 6104.0 6108.7 6110.0 6110.5 5778.0 5826.3 5873.9 5905.8 5959.3 6077.4 6132.5 6141.3 6143.6 6145.7 5809.7 5816.7 5827.2 5844.1 5851.1 5755.3 5797.2 5805.0 5865.5 5955.8 5759.5 5770.1 5783.6 5784.3 5789.3 5689.3 5716.5 5750.2 5785.0 5848.7 5614.7 5628.4 5643.0 5705.8 5761.4 5818.1 5823.8 5823.9 5835.5 5854.7 5524.1 5578.9 5624.1 5691.5 5694.1 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#1] ext.html Cycles:180 Average:72782.02 Median:43206.28 stddev:170197.23 (393.9%) stddev-sans-first:170588.33 09:52:13 INFO - PROCESS | 25856 | Values: 572.0 574.2 589.3 592.2 593.2 42796.4 44711.8 44764.3 47849.8 48164.5 44439.8 44702.0 44845.8 45059.8 45300.5 8906.2 9079.5 9080.3 9088.0 9090.0 8925.2 8986.5 9014.2 9019.2 9021.5 9070.2 9111.3 9111.5 9112.6 9117.2 8928.3 8982.7 8993.3 9024.5 9051.0 8884.6 8898.6 8940.1 8967.7 8977.5 43460.8 43811.0 43890.1 43947.8 44004.1 3412.2 3472.7 3475.5 3668.1 3837.4 32695.5 33276.3 33532.5 33616.3 33823.8 3668.1 3744.1 3795.8 3805.9 3830.0 374376.0 374660.0 375526.0 376215.0 376509.0 60928.1 61074.4 61561.0 61575.0 61636.0 36586.6 37355.3 37502.2 64514.8 64613.0 15002.0 15028.3 15085.8 15120.9 15146.4 10832.2 10947.1 10992.8 10995.3 11016.6 18837.5 18847.6 19045.2 19107.4 19116.5 6908.7 7106.8 7139.0 7185.6 7205.8 964.3 1018.7 1061.4 1061.7 1078.0 32129.8 32758.3 33078.2 33258.2 33715.8 893.4 1076.4 1141.1 1160.4 1193.1 17167.2 17333.7 17453.5 17455.5 17529.1 555690.0 942610.0 947003.0 953931.0 955266.0 59406.0 60092.4 60181.0 60271.7 60305.1 1341.1 1356.6 1368.6 1386.1 1386.6 31146.4 33666.3 33778.3 34092.7 34404.5 52501.7 53298.7 53343.7 53376.7 53449.5 514727.0 516303.0 517955.0 520810.0 522998.0 28632.4 28693.9 28986.3 29231.9 29340.4 47871.0 48907.3 49462.8 49888.0 50024.7 40014.4 40553.0 40646.6 43074.4 45456.0 39955.4 43201.0 44484.6 45239.0 46158.0 42667.0 42706.6 42773.8 43211.6 43321.0 32505.8 36612.8 37925.2 38283.4 38405.6 28302.0 28319.3 28625.0 29070.3 29232.7 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#2] jquery.html Cycles:180 Average:27776.59 Median:20367.14 stddev:75376.84 (370.1%) stddev-sans-first:75560.27 09:52:13 INFO - PROCESS | 25856 | Values: 404.4 405.4 405.8 416.1 429.1 15412.5 17783.9 18526.5 19370.4 19400.9 17542.6 17778.5 18198.5 18479.1 18559.5 5755.9 5767.5 5778.1 5807.9 5838.8 5759.1 5855.8 5861.9 5865.2 5866.7 5659.9 5748.9 5777.5 5796.9 5798.0 5589.9 5751.1 5816.9 5820.6 5835.9 5109.6 5201.0 5205.7 5213.6 5214.5 22966.5 23651.2 23662.9 23687.0 23711.6 2401.1 2430.0 2491.8 2515.4 3054.6 14901.9 14903.9 14960.7 15038.0 15636.7 1918.4 1924.3 1925.7 1940.8 1955.5 80241.6 81817.6 82310.0 82971.0 84589.0 10408.4 10505.3 10626.6 10739.9 10898.3 13430.5 15379.4 15549.1 15552.5 15580.8 7052.8 7834.9 7851.1 7875.7 8179.1 7358.9 7396.6 7463.8 7657.3 7695.0 6568.9 6666.9 6709.9 6833.4 6872.2 1942.4 1962.8 1965.2 2009.6 2009.7 925.6 929.3 939.0 959.7 1027.2 18843.0 20606.5 20726.6 20726.8 20960.4 969.8 1018.4 1034.8 1084.4 1120.6 10763.2 11629.7 11672.4 11810.8 11833.1 451444.0 452314.0 458470.0 461460.0 462633.0 84213.6 84791.0 84907.0 85321.0 86021.1 984.1 1016.3 1034.0 1046.0 1048.1 17356.2 17516.5 17920.0 18138.7 18205.7 37679.6 38818.4 39516.0 39663.8 41138.6 50992.7 51012.5 51274.0 52893.2 53875.6 8587.1 8730.9 8938.6 9050.1 9077.5 12636.2 12818.9 12888.5 13256.0 13273.3 11367.7 11411.5 11568.3 11750.1 12310.2 11160.6 11438.9 11513.2 11620.8 11744.4 11177.8 11452.4 11625.9 11776.7 12194.0 8508.7 8732.8 8748.6 8783.8 9014.9 5508.6 5625.7 5871.0 10913.6 11427.8 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#3] mootools.html Cycles:180 Average:5668.80 Median:5057.11 stddev:3188.39 (63.0%) stddev-sans-first:3181.38 09:52:13 INFO - PROCESS | 25856 | Values: 1424.3 1453.8 1567.7 1637.9 1709.4 7622.9 7914.8 8143.8 8869.2 8907.5 8163.5 8541.1 8595.1 8766.3 8833.3 2312.2 2339.4 2342.2 2342.7 2363.7 2265.9 2315.5 2316.8 2317.6 2321.4 2286.1 2304.6 2318.4 2337.8 2338.4 2205.4 2248.7 2250.9 2253.6 2272.0 2218.6 2227.3 2230.4 2231.4 2233.5 8844.2 8925.1 8930.0 8942.2 8959.6 4882.8 4913.7 5017.1 5045.6 5068.6 3226.6 3289.7 3418.7 3438.1 3444.1 1101.7 1126.7 1135.0 1150.9 1155.2 11531.8 11640.3 11677.7 11705.7 11786.9 4295.5 4435.3 4534.2 4595.7 4609.3 9931.6 9942.8 9980.9 9999.6 10011.5 4962.9 4963.8 5010.9 5015.7 5019.6 4055.0 4180.2 4407.5 4540.7 4578.6 3745.9 3855.9 3873.7 3884.8 3957.8 1276.2 1286.4 1288.8 1292.3 1295.3 743.8 837.5 932.2 941.2 947.0 5719.7 5814.3 6035.4 6126.8 6188.9 927.8 932.9 938.3 983.3 1013.0 4153.4 4277.3 4279.4 4304.6 4317.3 10504.3 11029.0 11061.1 11062.7 11090.7 10599.8 10900.9 10921.1 10929.5 10992.8 7221.5 7395.1 7410.4 7427.4 7485.5 5865.6 5908.2 6013.5 6018.9 6151.6 9648.4 9666.2 9681.4 9702.2 9778.3 9017.9 9586.1 9604.8 9633.7 9670.6 6774.9 7026.3 7199.7 7606.2 7718.1 8236.7 8642.9 8648.9 8662.1 8691.0 7410.7 7471.0 7490.3 7527.8 7729.1 7317.4 7365.6 7422.5 7438.6 7716.8 7072.4 7210.6 7221.7 7229.9 7236.3 5197.6 5199.4 5209.2 5416.4 5463.2 5334.9 5338.2 5376.0 5379.9 5476.3 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#4] prototype.html Cycles:180 Average:4703.55 Median:5222.65 stddev:1350.69 (25.9%) stddev-sans-first:1313.75 09:52:13 INFO - PROCESS | 25856 | Values: 317.4 331.4 338.6 340.9 343.5 5386.2 5523.2 5551.3 5566.3 5578.0 5438.8 5465.7 5467.9 5482.8 5483.0 4354.4 4370.4 4377.8 4384.3 4409.5 4305.8 4336.7 4356.0 4379.5 4412.8 4271.2 4314.2 4323.5 4328.9 4338.9 4312.4 4345.3 4347.5 4363.8 4369.0 3801.0 3836.9 3843.9 3902.4 3919.9 5291.2 5311.5 5332.3 5345.6 5385.8 4930.6 4957.3 4964.8 4969.9 4994.6 5474.8 5672.3 5733.9 5761.4 5768.4 4132.4 4150.0 4159.8 4183.8 4196.9 5766.9 5978.1 5996.6 6004.8 6020.5 4180.5 4197.8 4199.3 4218.8 4222.3 4238.4 4287.0 4288.2 4290.0 4292.8 4639.6 4899.2 4908.4 4916.1 4929.4 5725.5 5754.5 5767.2 5771.9 5801.2 1476.8 1478.3 1488.1 1494.7 1499.7 893.0 944.9 953.1 953.3 975.5 4868.8 4887.3 4898.3 4922.9 4958.8 5157.0 5211.9 5225.2 5231.5 5239.5 4637.8 4865.5 4925.4 4939.5 4952.6 2764.7 2788.9 2803.7 2835.6 2838.5 5430.7 5527.6 5527.7 5532.9 5545.9 5077.8 5207.0 5230.6 5284.5 5396.8 5347.0 5363.4 5376.8 5393.8 5508.6 5213.5 5220.6 5224.7 5250.8 5251.9 4977.5 5004.2 5018.5 5042.4 5090.4 5278.7 5959.7 6026.3 6105.6 6106.6 4256.8 4360.7 4371.1 4391.5 4400.1 5722.6 5916.8 5939.9 5973.5 5998.2 5684.3 5700.7 5702.8 5706.1 5715.2 5742.4 5762.6 5764.8 5765.5 5814.7 5518.3 5698.8 5724.9 5749.3 5795.3 5806.4 5824.5 5827.1 5858.4 5886.6 5552.6 5748.5 5789.9 5797.1 5805.0 09:52:13 INFO - PROCESS | 25856 | 09:52:13 INFO - PROCESS | 25856 | [#5] yui.html Cycles:180 Average:20106.56 Median:4502.84 stddev:29186.50 (648.2%) stddev-sans-first:29232.12 09:52:13 INFO - PROCESS | 25856 | Values: 729.5 777.2 782.8 823.0 853.4 15077.0 16383.7 16393.9 16400.9 16460.3 15387.6 15559.6 15564.8 15566.1 15602.4 779.2 783.8 807.4 810.2 819.4 808.6 813.0 814.6 816.2 816.7 848.5 849.5 851.6 853.2 853.5 845.7 848.7 848.7 850.9 851.0 612.7 619.8 620.2 621.8 622.5 14695.6 14718.4 14792.3 14871.8 14909.3 14642.7 15035.4 15056.5 15068.6 15171.9 10402.6 10447.2 10730.6 10755.4 11084.2 3734.8 3801.4 3882.1 3956.4 3958.3 57180.1 57602.0 58257.1 58685.0 75300.0 10517.8 10748.4 10754.8 10872.0 10941.5 21165.0 21269.1 21440.5 21453.5 21459.5 7703.8 7984.4 8275.5 8444.3 8444.4 4502.8 4720.3 4745.3 4772.9 4878.6 3287.6 3340.4 3368.6 3381.0 3383.3 571.6 592.1 593.6 602.4 615.4 706.6 716.0 729.6 734.1 763.4 8727.8 9212.4 9255.4 9359.2 9434.6 678.4 698.4 709.7 726.3 726.4 4316.3 4502.9 4544.5 4587.6 4634.7 113859.0 120488.0 125220.0 125519.0 127682.0 80895.6 84536.6 107240.5 110536.4 110712.0 50195.0 60313.0 80288.6 81697.6 85045.6 9581.7 9825.8 9956.6 9993.8 10014.6 46316.0 48039.5 48415.8 49764.5 50107.5 70044.0 70169.3 74654.6 75555.6 76484.2 12848.2 13076.7 13142.3 13312.4 13429.6 14781.1 14948.5 15608.4 15680.5 15701.7 13077.3 13213.6 13957.2 14235.4 14973.3 13410.2 13728.3 13837.0 13905.1 14396.3 12958.6 13677.2 13805.2 13844.1 14333.6 11134.2 11447.5 11459.9 11823.7 11882.2 10503.1 10788.4 11218.2 12201.1 12324.8 09:52:13 INFO - PROCESS | 25856 | -------- Summary: end -------- 09:52:13 INFO - PROCESS | 25856 | 09:52:14 INFO - TEST-INFO | 25856: exit 0 09:52:14 INFO - TEST-OK | dromaeo_css | took 1114206ms 09:52:14 INFO - TEST-START | kraken 09:52:14 INFO - operating with platform_type : linux_ 09:52:14 INFO - Initialising browser for kraken test... 09:52:14 INFO - TEST-INFO | started process 26214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphyzh9X/profile http://localhost:44226/getInfo.html) 09:52:18 INFO - PROCESS | 26214 | __metrics Screen width/height:1600/1200 09:52:18 INFO - PROCESS | 26214 | colorDepth:24 09:52:18 INFO - PROCESS | 26214 | Browser inner width/height: 1024/697 09:52:18 INFO - PROCESS | 26214 | __metrics 09:52:19 ERROR - PROCESS | 26214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 09:52:20 INFO - TEST-INFO | 26214: exit 0 09:52:20 INFO - Browser initialized. 09:52:20 INFO - Running cycle 1/1 for kraken test... 09:52:20 INFO - TEST-INFO | started process 26336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphyzh9X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:32 INFO - PROCESS | 26336 | RSS: Main: 185470976 09:52:32 INFO - PROCESS | 26336 | 09:52:35 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44226/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:36 INFO - PROCESS | 26336 | RSS: Main: 199528448 09:52:36 INFO - PROCESS | 26336 | 09:52:38 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44226/tests/kraken/driver.html?testName=audio-dft) 09:52:39 INFO - PROCESS | 26336 | RSS: Main: 197341184 09:52:39 INFO - PROCESS | 26336 | 09:52:42 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44226/tests/kraken/driver.html?testName=audio-fft) 09:52:42 INFO - PROCESS | 26336 | RSS: Main: 193077248 09:52:42 INFO - PROCESS | 26336 | 09:52:45 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44226/tests/kraken/driver.html?testName=audio-oscillator) 09:52:45 INFO - PROCESS | 26336 | RSS: Main: 193671168 09:52:45 INFO - PROCESS | 26336 | 09:52:47 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:48 INFO - PROCESS | 26336 | RSS: Main: 194002944 09:52:48 INFO - PROCESS | 26336 | 09:52:51 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44226/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:52 INFO - PROCESS | 26336 | RSS: Main: 193925120 09:52:52 INFO - PROCESS | 26336 | 09:52:55 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44226/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:56 INFO - PROCESS | 26336 | RSS: Main: 192065536 09:52:56 INFO - PROCESS | 26336 | 09:52:59 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44226/tests/kraken/driver.html?testName=json-parse-financial) 09:52:59 INFO - PROCESS | 26336 | RSS: Main: 192966656 09:52:59 INFO - PROCESS | 26336 | 09:53:01 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:01 INFO - PROCESS | 26336 | RSS: Main: 193560576 09:53:01 INFO - PROCESS | 26336 | 09:53:03 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:04 INFO - PROCESS | 26336 | RSS: Main: 193257472 09:53:04 INFO - PROCESS | 26336 | 09:53:06 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:07 INFO - PROCESS | 26336 | RSS: Main: 193339392 09:53:07 INFO - PROCESS | 26336 | 09:53:09 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:10 INFO - PROCESS | 26336 | RSS: Main: 193679360 09:53:10 INFO - PROCESS | 26336 | 09:53:13 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:13 INFO - PROCESS | 26336 | RSS: Main: 193626112 09:53:13 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | Cycle 1(1): loaded http://localhost:44226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44226/tests/kraken/driver.html?testName=ai-astar) 09:53:15 INFO - PROCESS | 26336 | RSS: Main: 195256320 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | __start_tp_report 09:53:15 INFO - PROCESS | 26336 | _x_x_mozilla_page_load 09:53:15 INFO - PROCESS | 26336 | _x_x_mozilla_page_load_details 09:53:15 INFO - PROCESS | 26336 | |i|pagename|runs| 09:53:15 INFO - PROCESS | 26336 | |0;ai-astar;108;113;117;114;112;113;112;112;112;112 09:53:15 INFO - PROCESS | 26336 | |1;audio-beat-detection;151;123;124;171;123;130;125;123;160;118 09:53:15 INFO - PROCESS | 26336 | |2;audio-dft;166;165;167;167;166;163;164;163;163;164 09:53:15 INFO - PROCESS | 26336 | |3;audio-fft;75;76;75;107;78;75;75;75;116;75 09:53:15 INFO - PROCESS | 26336 | |4;audio-oscillator;83;83;107;82;83;82;104;82;82;111 09:53:15 INFO - PROCESS | 26336 | |5;imaging-gaussian-blur;119;119;117;118;117;118;117;118;118;117 09:53:15 INFO - PROCESS | 26336 | |6;imaging-darkroom;148;147;146;147;155;147;147;148;148;148 09:53:15 INFO - PROCESS | 26336 | |7;imaging-desaturate;97;96;97;95;96;96;96;96;95;96 09:53:15 INFO - PROCESS | 26336 | |8;json-parse-financial;55;54;53;54;56;53;54;54;53;54 09:53:15 INFO - PROCESS | 26336 | |9;json-stringify-tinderbox;60;61;62;61;60;61;60;63;60;59 09:53:15 INFO - PROCESS | 26336 | |10;stanford-crypto-aes;82;80;80;80;80;87;80;80;79;82 09:53:15 INFO - PROCESS | 26336 | |11;stanford-crypto-ccm;135;129;126;124;145;127;124;130;155;133 09:53:15 INFO - PROCESS | 26336 | |12;stanford-crypto-pbkdf2;168;168;171;163;165;172;165;170;167;165 09:53:15 INFO - PROCESS | 26336 | |13;stanford-crypto-sha256-iterative;74;66;67;65;66;70;66;64;66;65 09:53:15 INFO - PROCESS | 26336 | __end_tp_report 09:53:15 INFO - PROCESS | 26336 | __start_cc_report 09:53:15 INFO - PROCESS | 26336 | _x_x_mozilla_cycle_collect,799 09:53:15 INFO - PROCESS | 26336 | __end_cc_report 09:53:15 INFO - PROCESS | 26336 | __startTimestamp1475167995839__endTimestamp 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | ------- Summary: start ------- 09:53:15 INFO - PROCESS | 26336 | Number of tests: 14 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:2.22 (2.0%) stddev-sans-first:1.66 09:53:15 INFO - PROCESS | 26336 | Values: 108.0 113.0 117.0 114.0 112.0 113.0 112.0 112.0 112.0 112.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.50 stddev:18.69 (14.7%) stddev-sans-first:18.88 09:53:15 INFO - PROCESS | 26336 | Values: 151.0 123.0 124.0 171.0 123.0 130.0 125.0 123.0 160.0 118.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.50 stddev:1.62 (1.0%) stddev-sans-first:1.66 09:53:15 INFO - PROCESS | 26336 | Values: 166.0 165.0 167.0 167.0 166.0 163.0 164.0 163.0 163.0 164.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:15.36 (20.5%) stddev-sans-first:16.03 09:53:15 INFO - PROCESS | 26336 | Values: 75.0 76.0 75.0 107.0 78.0 75.0 75.0 75.0 116.0 75.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:12.15 (14.8%) stddev-sans-first:12.63 09:53:15 INFO - PROCESS | 26336 | Values: 83.0 83.0 107.0 82.0 83.0 82.0 104.0 82.0 82.0 111.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 09:53:15 INFO - PROCESS | 26336 | Values: 119.0 119.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:2.51 (1.7%) stddev-sans-first:2.67 09:53:15 INFO - PROCESS | 26336 | Values: 148.0 147.0 146.0 147.0 155.0 147.0 147.0 148.0 148.0 148.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:53:15 INFO - PROCESS | 26336 | Values: 97.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 09:53:15 INFO - PROCESS | 26336 | Values: 55.0 54.0 53.0 54.0 56.0 53.0 54.0 54.0 53.0 54.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:1.16 (1.9%) stddev-sans-first:1.20 09:53:15 INFO - PROCESS | 26336 | Values: 60.0 61.0 62.0 61.0 60.0 61.0 60.0 63.0 60.0 59.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:2.31 (2.9%) stddev-sans-first:2.42 09:53:15 INFO - PROCESS | 26336 | Values: 82.0 80.0 80.0 80.0 80.0 87.0 80.0 80.0 79.0 82.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.50 stddev:10.02 (7.6%) stddev-sans-first:10.60 09:53:15 INFO - PROCESS | 26336 | Values: 135.0 129.0 126.0 124.0 145.0 127.0 124.0 130.0 155.0 133.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:2.95 (1.8%) stddev-sans-first:3.12 09:53:15 INFO - PROCESS | 26336 | Values: 168.0 168.0 171.0 163.0 165.0 172.0 165.0 170.0 167.0 165.0 09:53:15 INFO - PROCESS | 26336 | 09:53:15 INFO - PROCESS | 26336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:2.96 (4.5%) stddev-sans-first:1.69 09:53:15 INFO - PROCESS | 26336 | Values: 74.0 66.0 67.0 65.0 66.0 70.0 66.0 64.0 66.0 65.0 09:53:15 INFO - PROCESS | 26336 | -------- Summary: end -------- 09:53:15 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - PROCESS | 26336 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:53:16 INFO - PROCESS | 26336 | 09:53:16 INFO - TEST-INFO | 26336: exit 0 09:53:16 INFO - TEST-OK | kraken | took 62601ms 09:53:16 INFO - SUITE-END | took 1176s 09:53:17 INFO - Completed test suite (00:19:36) 09:53:17 INFO - javascript benchmark 09:53:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7276.6539480865495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.233941514621, 3083.306256092381, 3101.736352410045, 3116.937661246775, 3118.064580625813, 5361.544268737152, 5404.891902161954, 5482.122860342346, 5499.395066542682, 5499.917501237484, 5388.0570900092525, 5388.137897936331, 5401.189821526773, 5453.509184173424, 5475.178723191523, 4869.0, 4974.253861920704, 5012.273220383042, 5039.697618142924, 5057.190849464087, 4998.250262460624, 5005.879055183727, 5050.924236136461, 5058.165402708549, 5059.949400506003, 4857.854264372075, 4875.731834749087, 4922.507749225085, 4951.009798040406, 5011.348524691785, 4981.9252711209365, 4997.30037794709, 4997.675151115202, 5052.242163675478, 5053.343065401511, 4918.213085906238, 4959.008198360342, 4962.379702537183, 4966.776495057731, 5037.748112594356, 5206.0368831766245, 5281.70950597717, 5325.653832500914, 5393.433689462589, 5455.208994695787, 5716.371199168088, 5796.97101514494, 5801.390853960358, 5864.5894787364905, 5866.882662346729, 5830.854228644275, 5839.240898683144, 5841.883162336772, 5847.561432892508, 5857.326407463153, 5393.9730301348245, 5402.297701298806, 5407.45925407464, 5410.269613602192, 5441.428649991693, 5846.795362162304, 5857.765689372377, 5908.025175846024, 5952.9107063394085, 6020.548458865603, 5658.660480371191, 5666.914996275059, 5667.574931880125, 5671.461211184931, 5707.942920570824, 5655.503963929006, 5670.121131224667, 5716.08542633185, 5756.395578464285, 5787.8553036174435, 5702.942970570324, 5753.0, 5780.583756979567, 5829.242198514251, 5897.970510147507, 5798.710064496759, 5803.361630220672, 5805.10020946754, 5807.68057756819, 5845.152452894306, 4390.319500477431, 4425.269830477935, 4435.889102772392, 4444.977775111104, 4501.752403617833, 3931.4692516509904, 3970.0471886746973, 4007.6593489553716, 4040.1717647882115, 4109.198706252312, 5581.804636837691, 5592.356878958972, 5602.1036634138345, 5605.215269862222, 5609.0, 5898.941010589925, 5941.079132734347, 5941.138534912414, 5944.940550594439, 5954.46409823118, 5318.175682769177, 5435.537979271727, 5452.318460192476, 5510.228568000483, 5517.475839795213, 4917.557419832161, 4930.975345123323, 4937.284093806378, 4939.604831613462, 4968.503149685002, 6088.908666370008, 6103.969480152659, 6108.717846559889, 6109.95128740435, 6110.528382738247, 5777.971110144591, 5826.271716035496, 5873.882522349443, 5905.822825315247, 5959.28488581373, 6077.35626103157, 6132.508481341157, 6141.345899189975, 6143.603994442082, 6145.678679084019, 5809.680467574324, 5816.73824677882, 5827.184194212899, 5844.12338149281, 5851.093080572518, 5755.3381361144, 5797.159411885169, 5804.970975145097, 5865.530757539302, 5955.821325360246, 5759.539236861125, 5770.076787714113, 5783.624064435799, 5784.305883294031, 5789.2763404574425, 5689.345725241485, 5716.485516303553, 5750.223719797774, 5784.971075144766, 5848.736806843787, 5614.747336369792, 5628.352739435018, 5643.0, 5705.800296989585, 5761.395053519488, 5818.0981947798155, 5823.767049317979, 5823.912641310299, 5835.533157347487, 5854.677992710272, 5524.088525393265, 5578.916316255179, 5624.100143976944, 5691.544676425959, 5694.060480020916], "value": 5380.988190315548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9885602287952, 574.2161948939697, 589.307563612755, 592.1857446011734, 593.237689568904, 42796.35805462921, 44711.77644111783, 44764.32853507196, 47849.760751196285, 48164.51835481644, 44439.77780111103, 44702.0, 44845.7757711211, 45059.77470112645, 45300.54699453004, 8906.242969347613, 9079.455232686027, 9080.318976076787, 9088.045755195708, 9090.0, 8925.152110549487, 8986.505742184178, 9014.233790127848, 9019.188273055424, 9021.548922553879, 9070.183683468487, 9111.27109831212, 9111.45331280122, 9112.635494580209, 9117.179453849152, 8928.330375221884, 8982.685606003759, 8993.325500587449, 9024.503652299089, 9050.954745226265, 8884.555772211364, 8898.555072246361, 8940.061293564147, 8967.730968070968, 8977.461352318882, 43460.78269608664, 43811.0, 43890.12219755587, 43947.78026109849, 44004.11991760179, 3412.1640198151363, 3472.687458128755, 3475.5134281200653, 3668.0646435158865, 3837.3668344723087, 32695.50956735651, 33276.33447331064, 33532.49701254483, 33616.32767344664, 33823.830880845686, 3668.1196512836996, 3744.120131769032, 3795.8481660733537, 3805.8858234253016, 3829.9617003829885, 374376.0, 374660.0, 375526.0, 376215.0, 376509.0, 60928.08607870885, 61074.38925610776, 61561.0, 61575.0, 61636.0, 36586.63413365885, 37355.25289494195, 37502.24995500075, 64514.77426128769, 64613.0, 15002.0, 15028.323725432381, 15085.773713394308, 15120.924395377953, 15146.394144234328, 10832.187585931088, 10947.124230061576, 10992.835107473395, 10995.285306455055, 11016.614418495474, 18837.529061773566, 18847.62304753897, 19045.238190472224, 19107.426777196706, 19116.470682345378, 6908.723651053901, 7106.786796396116, 7139.0, 7185.568865868065, 7205.819854503679, 964.3105179796479, 1018.7198520406947, 1061.4321338084087, 1061.7080302916759, 1077.9730506737394, 32129.839350803097, 32758.344833103205, 33078.17304567405, 33258.168545786066, 33715.83142084323, 893.4014210478995, 1076.4079756134095, 1141.1270378160714, 1160.4197901049474, 1193.1349771415655, 17167.227474763666, 17333.653326933392, 17453.476395707894, 17455.476335709947, 17529.12354382276, 555690.0, 942610.0, 947003.0, 953931.0, 955266.0, 59406.0, 60092.39907600868, 60181.0, 60271.69864150651, 60305.09542356868, 1341.081359268904, 1356.6269275949194, 1368.6167872995577, 1386.0713322074234, 1386.6394737368357, 31146.37707245797, 33666.326673465905, 33778.32443351168, 34092.65907340895, 34404.48393274153, 52501.7374913123, 53298.73350633222, 53343.73328133334, 53376.73311633417, 53449.465505346, 514727.0, 516303.0, 517955.0, 520810.0, 522998.0, 28632.427351453272, 28693.856530717214, 28986.275343115747, 29231.85384073066, 29340.413191736472, 47871.0, 48907.26639100487, 49462.75268623634, 49888.0, 50024.74987625039, 40014.39978400384, 40553.0, 40646.59353406428, 43074.353884691125, 45456.0, 39955.40066899057, 43201.0, 44484.555154449336, 45239.00783003903, 46158.0, 42667.0, 42706.572934271506, 42773.786131069144, 43211.56788432076, 43321.0, 32505.837470812494, 36612.81693591515, 37925.24149516939, 38283.425748613234, 38405.6159438402, 28302.0, 28319.298822895682, 28625.0, 29070.27324316909, 29232.707672923], "value": 20534.039756878323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.35909084101695, 405.36965019394836, 405.8112977465478, 416.09499338937815, 429.13957515182057, 15412.537623871274, 17783.911080444614, 18526.536836579093, 19370.418887433363, 19400.90299548502, 17542.64914701705, 17778.46664600064, 18198.545036374097, 18479.07604619767, 18559.536011599717, 5755.942440575593, 5767.529280033586, 5778.104393818965, 5807.854803629901, 5838.824835254928, 5759.078547432412, 5855.824325270249, 5861.941380586182, 5865.208196893429, 5866.677332746697, 5659.9058348411145, 5748.942510574903, 5777.45114214149, 5796.884062318751, 5797.971010144944, 5589.944100558983, 5751.10857817037, 5816.912746308788, 5820.621659592113, 5835.883282334372, 5109.642325037249, 5201.037808005531, 5205.687658740488, 5213.556847667953, 5214.530692237717, 22966.54066918669, 23651.172208972603, 23662.881685591634, 23687.0, 23711.644325335135, 2401.1355911871888, 2429.9514009719883, 2491.763282488179, 2515.3963048868322, 3054.648715397713, 14901.92549037248, 14903.850961490463, 14960.700785984329, 15038.0, 15636.687266254612, 1918.386116442739, 1924.288013435038, 1925.7015162649811, 1940.805919408062, 1955.5404479947201, 80241.59879200567, 81817.59091204565, 82310.0, 82971.0, 84589.0, 10408.449929767105, 10505.26863015606, 10626.574937002588, 10739.892601073889, 10898.278403838049, 13430.529931452353, 15379.385164557783, 15549.144797036271, 15552.455664051704, 15580.831437642222, 7052.753153639598, 7834.882476762853, 7851.136374998746, 7875.684972601031, 8179.100298967109, 7358.8528229435115, 7396.630168491554, 7463.7532673286205, 7657.349125324298, 7695.038120234971, 6568.901466478007, 6666.933330666729, 6709.865802684017, 6833.384995350442, 6872.244053154149, 1942.4464027752306, 1962.823345898876, 1965.1942703491786, 2009.6081264153643, 2009.728686627316, 925.5973651461636, 929.330881765128, 939.0468674295458, 959.7072892767633, 1027.209049032241, 18842.963637000095, 20606.484837879172, 20726.58546829055, 20726.792732072485, 20960.37118886436, 969.8496733006396, 1018.4144117132678, 1034.8395998620076, 1084.360227465799, 1120.6469961961957, 10763.24657273999, 11629.651110466699, 11672.358020308795, 11810.822837657443, 11833.112516561292, 451444.0, 452314.0, 458470.0, 461460.0, 462633.0, 84213.57893210495, 84791.0, 84907.0, 85321.0, 86021.13978860257, 984.1192133041031, 1016.3038318751679, 1033.9534720937577, 1046.0115191144296, 1048.124815778818, 17356.218970146627, 17516.525963683027, 17920.0, 18138.72791908096, 18205.726914096034, 37679.62320376761, 38818.41772373473, 39516.0, 39663.80168099256, 41138.58861411468, 50992.74503627458, 51012.48987510077, 51274.0, 52893.20660190177, 53875.61243875738, 8587.141285871363, 8730.869036964323, 8938.553072346487, 9050.140236677506, 9077.546122693971, 12636.2418254905, 12818.935905320413, 12888.548900788428, 13256.0, 13273.269970151734, 11367.658970230907, 11411.486483108114, 11568.305901645928, 11750.11874109428, 12310.199837010565, 11160.609378672032, 11438.94280528592, 11513.194076414571, 11620.825687614863, 11744.354060526754, 11177.832332515181, 11452.427378631202, 11625.941870290595, 11776.70558236051, 12194.0, 8508.659653613786, 8732.78168045804, 8748.606312715816, 8783.780405489913, 9014.909850901407, 5508.55931525469, 5625.718714064198, 5871.035127260706, 10913.635795525559, 11427.771444570895], "value": 9252.786108882707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.2807382271953, 1453.8473460286668, 1567.6942996115754, 1637.9181040947965, 1709.4187976088128, 7622.923770762291, 7914.80212994674, 8143.755687329382, 8869.246114080303, 8907.46555206688, 8163.469374490669, 8541.060483346826, 8595.140485951402, 8766.34252431067, 8833.293336533077, 2312.2022902098747, 2339.368370539953, 2342.2387723989686, 2342.7188737351544, 2363.6927199464044, 2265.8527195732227, 2315.548468048731, 2316.791488766011, 2317.571249318881, 2321.4446320964907, 2286.142696488817, 2304.562133194696, 2318.420394901275, 2337.801286890616, 2338.403707054707, 2205.44863784054, 2248.6627005949076, 2250.8987095580655, 2253.5943530164564, 2271.977280227193, 2218.556288742258, 2227.3429338345227, 2230.364346161336, 2231.3752149398197, 2233.5197932444603, 8844.159804818531, 8925.107489251088, 8930.0, 8942.239909607692, 8959.596818143134, 4882.829100981484, 4913.680610760289, 5017.096922553938, 5045.621578381636, 5068.594512438996, 3226.5644138041534, 3289.687479689426, 3418.6581341865863, 3438.1404648837793, 3444.1389652586854, 1101.6529793115144, 1126.707056165403, 1134.9773004539945, 1150.896419322265, 1155.185594156118, 11531.769364612745, 11640.301581905029, 11677.70805729855, 11705.70735731605, 11786.941065294619, 4295.463067116611, 4435.290353543418, 4534.161180181611, 4595.747233902101, 4609.308603709471, 9931.553080111413, 9942.751431214278, 9980.850287245697, 9999.550020249106, 10011.549480273405, 4962.8759281018265, 4963.801447942042, 5010.949890501049, 5015.699058056528, 5019.648624596316, 4054.959450405458, 4180.205760905418, 4407.537208593116, 4540.72755634663, 4578.587927086578, 3745.9250814983548, 3855.9228815423535, 3873.6707379872464, 3884.8251828667776, 3957.841686332572, 1276.1959965221852, 1286.4275397448046, 1288.7809072457705, 1292.3086148910477, 1295.2811189789757, 743.8177646476648, 837.4556538250064, 932.2076235200161, 941.1858742188095, 947.0292949726586, 5719.656820590778, 5814.3313518945015, 6035.366286539938, 6126.754929802758, 6188.938110618837, 927.8190752803139, 932.8740620016347, 938.3009657804979, 983.306768728045, 1012.964546240878, 4153.418521407006, 4277.272863613131, 4279.358096285582, 4304.569543045671, 4317.330813723878, 10504.264701470824, 11029.0, 11061.115110791117, 11062.668119956414, 11090.722731931604, 10599.84100238497, 10900.945495272474, 10921.12630989519, 10929.453527323602, 10992.780144397067, 7221.494495385377, 7395.149557800814, 7410.444216683771, 7427.44294177928, 7485.513441626277, 5865.648061116347, 5908.202392676933, 6013.548983826143, 6018.909716354171, 6151.630902145886, 9648.372855764354, 9666.226701863694, 9681.37071090377, 9702.223822094356, 9778.266630002636, 9017.864732029157, 9586.089321514444, 9604.75988100303, 9633.687914900514, 9670.613175472903, 6774.898376524455, 7026.332498412643, 7199.71201151948, 7606.239376062349, 7718.073831140299, 8236.682130859033, 8642.913570864212, 8648.870266945874, 8662.13378662154, 8691.043985161754, 7410.666520006721, 7471.028766260351, 7490.288422599844, 7527.774166775005, 7729.149793522821, 7317.378022868116, 7365.594892280762, 7422.480426370318, 7438.59087750179, 7716.807079823049, 7072.434205263464, 7210.639468026683, 7221.67502462401, 7229.855402892018, 7236.312550307713, 5197.610179236648, 5199.428062913152, 5209.218617207449, 5416.37711663148, 5463.207834864002, 5334.866628334167, 5338.199270109515, 5376.0, 5379.865503362447, 5476.288082549243], "value": 4553.122073181778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.3684368107467, 331.4415210370526, 338.6342749830184, 340.8819073439119, 343.49334731271364, 5386.192071189319, 5523.226748255248, 5551.306086739158, 5566.332040155177, 5578.0, 5438.782448702057, 5465.699386533739, 5467.890642187154, 5482.835514934548, 5482.972585137079, 4354.412154359168, 4370.431843860294, 4377.759223242729, 4384.298512238027, 4409.4708634963845, 4305.849295274666, 4336.653067754588, 4355.978220108911, 4379.474463064421, 4412.75729834859, 4271.231178387889, 4314.180305741915, 4323.5460276670965, 4328.870133895988, 4338.869833904988, 4312.417823593822, 4345.304751239786, 4347.5217726050105, 4363.847265345697, 4369.0, 3800.9592326138977, 3836.8848934532007, 3843.8846834595006, 3902.439024390238, 3919.862804801847, 5291.232771248186, 5311.468853114697, 5332.280142180794, 5345.572354211693, 5385.838424847261, 4930.630202734809, 4957.256411538262, 4964.801407943678, 4969.856932905452, 4994.55049045584, 5474.808381706621, 5672.319321681383, 5733.856653583652, 5761.395053519362, 5768.394318596571, 4132.421460995463, 4149.97925010376, 4159.771212583307, 4183.769892655902, 4196.895077623053, 5766.913496297559, 5978.103284507359, 5996.640201587875, 6004.819855404345, 6020.518358531307, 4180.540140584533, 4197.790110494463, 4199.349100889367, 4218.810153543098, 4222.303319952235, 4238.449001629769, 4286.978565107217, 4288.206681763883, 4289.957100429018, 4292.763897985641, 4639.605633521121, 4899.191633380452, 4908.435529914034, 4916.139675556763, 4929.359183306219, 5725.541956643458, 5754.482096611325, 5767.22142510764, 5771.922108041102, 5801.158831969341, 1476.8375478697335, 1478.2608695652175, 1488.1368806092441, 1494.7160039592443, 1499.6925630245773, 892.9728221329698, 944.8771659684335, 953.0993211415284, 953.2659851913987, 975.492743773234, 4868.78090485929, 4887.29134275528, 4898.2652602109965, 4922.926156107661, 4958.776855041532, 5156.9742151289, 5211.869703257449, 5225.242339860699, 5231.450697676689, 5239.502247286502, 4637.837675681335, 4865.537773911473, 4925.359703238556, 4939.48135445773, 4952.603791696655, 2764.654418197725, 2788.888444462199, 2803.710293265121, 2835.6030155778208, 2838.5458326667635, 5430.664814129883, 5527.585431092603, 5527.668339899619, 5532.86167845799, 5545.890821835568, 5077.847664570068, 5207.0366982108435, 5230.593926793641, 5284.497972692588, 5396.784128634889, 5346.973265133727, 5363.436839131835, 5376.758045887945, 5393.763741754916, 5508.614396992252, 5213.478652134756, 5220.634555581073, 5224.66039707433, 5250.816221432385, 5251.921221181609, 4977.502249775139, 5004.2493625956395, 5018.548330650259, 5042.369703787027, 5090.447413538906, 5278.656887302467, 5959.67221802805, 6026.3126324629175, 6105.572609917263, 6106.603070800384, 4256.829726811016, 4360.716553424018, 4371.054880578239, 4391.516933137288, 4400.141972315368, 5722.595055941708, 5916.763329466773, 5939.881202376015, 5973.462388384893, 5998.160257563857, 5684.261046063985, 5700.743466543932, 5702.8289151325525, 5706.144078388275, 5715.199872017838, 5742.36833948257, 5762.645778242194, 5764.798232061858, 5765.509931655856, 5814.73833677494, 5518.255035570147, 5698.800541981011, 5724.942750572608, 5749.338826035059, 5795.291013751287, 5806.390329015392, 5824.475797178275, 5827.096799996008, 5858.443447872445, 5886.558508111994, 5552.555795536428, 5748.45389687979, 5789.913151302818, 5797.130430435468, 5805.010419633808], "value": 4271.941951191346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.5330988167572, 777.2111307023372, 782.7573452229806, 822.9588520573969, 853.389826274214, 15077.0, 16383.672326553462, 16393.91803040983, 16400.917995410007, 16460.259288332025, 15387.615309617266, 15559.611009724762, 15564.844351556481, 15566.143862087582, 15602.375904963788, 779.2052106851008, 783.7844592737, 807.4347956430493, 810.2302812328282, 819.3772732723114, 808.6320724070563, 813.0203105258179, 814.6252723747053, 816.1756625807947, 816.7182322098867, 848.4909054567272, 849.4987957105307, 851.595492141231, 853.2406158518924, 853.5007020892785, 845.6744153500915, 848.6520526584133, 848.6775025490335, 850.8596081646521, 851.0213254757078, 612.702839123025, 619.761391864131, 620.2247191011236, 621.8196722950385, 622.5019984012772, 14695.63260918475, 14718.411263549446, 14792.334344954503, 14871.776923346159, 14909.254537273093, 14642.70714585713, 15035.377652079078, 15056.548303550911, 15068.623284417978, 15171.924140379338, 10402.5838966442, 10447.216458765546, 10730.570777168903, 10755.354678719303, 11084.224104312701, 3734.775913445175, 3801.4487899254455, 3882.0683036071423, 3956.4065390191413, 3958.2875082485143, 57180.14229786557, 57602.0, 58257.12614310789, 58685.0, 75299.99999999945, 10517.84223236652, 10748.408837514013, 10754.838677419844, 10872.0, 10941.4529273536, 21165.0, 21269.149234030465, 21440.463988400414, 21453.463663408227, 21459.46351341229, 7703.768886933401, 7984.441089123822, 8275.54484503358, 8444.282236009885, 8444.408891377667, 4502.774861256924, 4720.33915251865, 4745.264484004984, 4772.856814295576, 4878.609711223094, 3287.6383597804224, 3340.398728228942, 3368.5789276340456, 3380.983095084509, 3383.3402486515383, 571.5570432914525, 592.1295695327861, 593.6438137117781, 602.4367216652444, 615.3600255733986, 706.5654622407183, 715.9821004474929, 729.5659082845698, 734.097060615446, 763.4083585221387, 8727.781805454788, 9212.447253164697, 9255.35212535116, 9359.221747867883, 9434.622615095319, 678.4402867634221, 698.4272896225046, 709.6522703875064, 726.2882375272263, 726.3620535692086, 4316.309390497506, 4502.909941801146, 4544.545545445495, 4587.587117159472, 4634.675572709945, 113859.0, 120488.0, 125220.0, 125519.0, 127682.0, 80895.59552202202, 84536.57731711425, 107240.46379768207, 110536.4473177629, 110712.0, 50195.0, 60313.0, 80288.59855700684, 81697.59151204205, 85045.57477212822, 9581.664641737505, 9825.840380995973, 9956.55195516218, 9993.800123997335, 10014.575669538845, 46316.0, 48039.51960480351, 48415.75792121017, 49764.502354975986, 50107.49892501028, 70044.0, 70169.29830701627, 74654.62672686602, 75555.62222188854, 76484.23515764771, 12848.229106253655, 13076.738465230452, 13142.34288285601, 13312.400941957441, 13429.597112086652, 14781.05903786128, 14948.476803311833, 15608.375664973728, 15680.451184208498, 15701.685966280382, 13077.291217994842, 13213.603591892259, 13957.162570245819, 14235.35940882642, 14973.32620032123, 13410.195388276734, 13728.313584320944, 13837.0, 13905.096168749, 14396.280185990448, 12958.611241662766, 13677.24775137377, 13805.17168969865, 13844.100133491695, 14333.56999290023, 11134.220604557604, 11447.484863181011, 11459.942700286445, 11823.70440738954, 11882.16824822254, 10503.061351993003, 10788.352698838095, 11218.214724969173, 12201.14591978553, 12324.815127772912], "value": 7464.5017284455735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 117.0, 114.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 124.0, 171.0, 123.0, 130.0, 125.0, 123.0, 160.0, 118.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 167.0, 166.0, 163.0, 164.0, 163.0, 163.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 78.0, 75.0, 75.0, 75.0, 116.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 82.0, 83.0, 82.0, 104.0, 82.0, 82.0, 111.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 155.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 56.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 60.0, 61.0, 60.0, 63.0, 60.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 80.0, 80.0, 87.0, 80.0, 80.0, 79.0, 82.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 126.0, 124.0, 145.0, 127.0, 124.0, 130.0, 155.0, 133.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 171.0, 163.0, 165.0, 172.0, 165.0, 170.0, 167.0, 165.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 67.0, 65.0, 66.0, 70.0, 66.0, 64.0, 66.0, 65.0], "value": 66.9, "unit": "score"}]}]} 09:53:17 INFO - Return code: 0 09:53:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:17 ERROR - # TBPL SUCCESS # 09:53:17 INFO - Running post-action listener: _resource_record_post_action 09:53:17 INFO - [mozharness: 2016-09-29 16:53:17.159827Z] Finished run-tests step (success) 09:53:17 INFO - Running post-run listener: _resource_record_post_run 09:53:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393695232; Read time: 244; Write time: 385336 09:53:17 INFO - TinderboxPrint: CPU usage
13.5% 09:53:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 244 09:53:17 INFO - TinderboxPrint: I/O write bytes / time
393,695,232 / 385,336 09:53:17 INFO - TinderboxPrint: CPU idle
8,237.7 (86.5%) 09:53:17 INFO - TinderboxPrint: CPU user
1,220.4 (12.8%) 09:53:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105529344; Read time: 0; Write time: 132488 09:53:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288165888; Read time: 232; Write time: 252848 09:53:17 INFO - Running post-run listener: _upload_blobber_files 09:53:17 INFO - Blob upload gear active. 09:53:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:53:17 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:17 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:24 INFO - (blobuploader) - INFO - Done attempting. 09:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:26 INFO - (blobuploader) - INFO - Done attempting. 09:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:27 INFO - (blobuploader) - INFO - Done attempting. 09:53:27 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:27 INFO - Return code: 0 09:53:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9b0ddbe4bac0d18b915b8e3bbc4334b27608a42f60ebb1d05055f9ca8c13a2b8ae26c1c41eac45817b120711a807deb57943518d113d79521027f00ddfe453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/10df7c7ca7b5eb42d536acf33b0d2bdf580573c1223d22dd36cfe0924aa4274004eecc4aaa8719fc41533b3c298d410d3ac8e5c023e8b2e78020075ea06dd566", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e90e52672ffe31c324cbd411f32552d705f1c76f551c8b7cdbb01ef78969fdec528831fe0f65e54fd979e5c2adbc9a00d4f51579ba1ad9c568956c1db99969ff"} 09:53:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:27 INFO - Contents: 09:53:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9b0ddbe4bac0d18b915b8e3bbc4334b27608a42f60ebb1d05055f9ca8c13a2b8ae26c1c41eac45817b120711a807deb57943518d113d79521027f00ddfe453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/10df7c7ca7b5eb42d536acf33b0d2bdf580573c1223d22dd36cfe0924aa4274004eecc4aaa8719fc41533b3c298d410d3ac8e5c023e8b2e78020075ea06dd566", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e90e52672ffe31c324cbd411f32552d705f1c76f551c8b7cdbb01ef78969fdec528831fe0f65e54fd979e5c2adbc9a00d4f51579ba1ad9c568956c1db99969ff"} 09:53:27 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:27 INFO - Copying logs to upload dir... 09:53:27 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.737879 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-29 09:53:27.007688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:53:27.011106) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9b0ddbe4bac0d18b915b8e3bbc4334b27608a42f60ebb1d05055f9ca8c13a2b8ae26c1c41eac45817b120711a807deb57943518d113d79521027f00ddfe453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/10df7c7ca7b5eb42d536acf33b0d2bdf580573c1223d22dd36cfe0924aa4274004eecc4aaa8719fc41533b3c298d410d3ac8e5c023e8b2e78020075ea06dd566", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e90e52672ffe31c324cbd411f32552d705f1c76f551c8b7cdbb01ef78969fdec528831fe0f65e54fd979e5c2adbc9a00d4f51579ba1ad9c568956c1db99969ff"} build_url:https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/NCxhsNt7SuaWfxCOyvCxXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9b0ddbe4bac0d18b915b8e3bbc4334b27608a42f60ebb1d05055f9ca8c13a2b8ae26c1c41eac45817b120711a807deb57943518d113d79521027f00ddfe453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/10df7c7ca7b5eb42d536acf33b0d2bdf580573c1223d22dd36cfe0924aa4274004eecc4aaa8719fc41533b3c298d410d3ac8e5c023e8b2e78020075ea06dd566", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e90e52672ffe31c324cbd411f32552d705f1c76f551c8b7cdbb01ef78969fdec528831fe0f65e54fd979e5c2adbc9a00d4f51579ba1ad9c568956c1db99969ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:53:27.037218) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:53:27.037550) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475166765.87741-1928045141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:53:27.121666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:53:27.122028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:53:27.122348) ========= ========= Total master_lag: 0.18 =========