builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1476765494.41 results: success (0) buildid: 20161017212943 builduid: 5b8c65480dcf441ab935ac06cd02694a revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.405601) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.406029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.406319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.420786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.421102) ========= 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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 21:38:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2016-10-17 21:38:14 (22.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.558245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.558567) ========= 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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.608286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:14.608607) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47be3ae8a710b35f040dffe7403877e764ab61ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 47be3ae8a710b35f040dffe7403877e764ab61ac --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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 21:38:15,068 truncating revision to first 12 chars 2016-10-17 21:38:15,068 Setting DEBUG logging. 2016-10-17 21:38:15,068 attempt 1/10 2016-10-17 21:38:15,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47be3ae8a710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 21:38:15,378 unpacking tar archive at: fx-team-47be3ae8a710/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:15.284128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:15.284491) ========= script_repo_revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:15.284930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:15.285233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:38:15.295886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-17 21:38:15.296146) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:38:15 INFO - MultiFileLogger online at 20161017 21:38:15 in /builds/slave/test 21:38:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:38:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:38:15 INFO - {'append_to_log': False, 21:38:15 INFO - 'base_work_dir': '/builds/slave/test', 21:38:15 INFO - 'blob_upload_branch': 'Fx-Team', 21:38:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:38:15 INFO - 'branch': 'Fx-Team', 21:38:15 INFO - 'buildbot_json_path': 'buildprops.json', 21:38:15 INFO - 'config_files': ('talos/linux_config.py',), 21:38:15 INFO - 'default_actions': ('clobber', 21:38:15 INFO - 'read-buildbot-config', 21:38:15 INFO - 'download-and-extract', 21:38:15 INFO - 'populate-webroot', 21:38:15 INFO - 'create-virtualenv', 21:38:15 INFO - 'install', 21:38:15 INFO - 'run-tests'), 21:38:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:38:15 INFO - 'download_minidump_stackwalk': True, 21:38:15 INFO - 'download_symbols': 'ondemand', 21:38:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:38:15 INFO - 'tooltool.py': '/tools/tooltool.py', 21:38:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:38:15 INFO - '/tools/misc-python/virtualenv.py')}, 21:38:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:38:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:38:15 INFO - 'installer_path': 'installer.exe', 21:38:15 INFO - 'log_level': 'info', 21:38:15 INFO - 'log_name': 'talos', 21:38:15 INFO - 'log_to_console': True, 21:38:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:38:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:38:15 INFO - 'opt_config_files': (), 21:38:15 INFO - 'pip_index': False, 21:38:15 INFO - 'sps_profile': False, 21:38:15 INFO - 'sps_profile_interval': 0, 21:38:15 INFO - 'suite': 'dromaeojs', 21:38:15 INFO - 'system_bits': '32', 21:38:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:38:15 INFO - 'title': 'talos-linux64-ix-041', 21:38:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:38:15 INFO - 'use_talos_json': True, 21:38:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:38:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:38:15 INFO - 'work_dir': 'build'} 21:38:15 INFO - [mozharness: 2016-10-18 04:38:15.847679Z] Running clobber step. 21:38:15 INFO - Running pre-action listener: _resource_record_pre_action 21:38:15 INFO - Running main action method: clobber 21:38:15 INFO - rmtree: /builds/slave/test/build 21:38:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:38:16 INFO - Running post-action listener: _resource_record_post_action 21:38:16 INFO - [mozharness: 2016-10-18 04:38:16.838584Z] Finished clobber step (success) 21:38:16 INFO - [mozharness: 2016-10-18 04:38:16.838683Z] Running read-buildbot-config step. 21:38:16 INFO - Running pre-action listener: _resource_record_pre_action 21:38:16 INFO - Running main action method: read_buildbot_config 21:38:16 INFO - Using buildbot properties: 21:38:16 INFO - { 21:38:16 INFO - "project": "", 21:38:16 INFO - "product": "firefox", 21:38:16 INFO - "script_repo_revision": "production", 21:38:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:38:16 INFO - "repository": "", 21:38:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:38:16 INFO - "buildid": "20161017212943", 21:38:16 INFO - "stage_platform": "linux64-pgo", 21:38:16 INFO - "basedir": "/builds/slave/test", 21:38:16 INFO - "buildnumber": 1145, 21:38:16 INFO - "platform": "ubuntu64_hw", 21:38:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:38:16 INFO - "slavebuilddir": "test", 21:38:16 INFO - "branch": "fx-team", 21:38:16 INFO - "revision": "47be3ae8a710b35f040dffe7403877e764ab61ac", 21:38:16 INFO - "slavename": "talos-linux64-ix-041", 21:38:16 INFO - "builduid": "5b8c65480dcf441ab935ac06cd02694a", 21:38:16 INFO - "repo_path": "integration/fx-team" 21:38:16 INFO - } 21:38:16 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:38:16 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:38:16 INFO - Running post-action listener: _resource_record_post_action 21:38:16 INFO - [mozharness: 2016-10-18 04:38:16.841063Z] Finished read-buildbot-config step (success) 21:38:16 INFO - [mozharness: 2016-10-18 04:38:16.841151Z] Running download-and-extract step. 21:38:16 INFO - Running pre-action listener: _resource_record_pre_action 21:38:16 INFO - Running main action method: download_and_extract 21:38:16 INFO - mkdir: /builds/slave/test/build/tests 21:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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 21:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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 21:38:16 INFO - Downloaded 1361 bytes. 21:38:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:16 INFO - Using the following test package requirements: 21:38:16 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:38:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:38:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'jsshell-linux-x86_64.zip'], 21:38:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:38:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:38:16 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:38:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:38:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:38:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:38:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:16 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:16 INFO - Http code: 200 21:38:16 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 21:38:16 INFO - x-amz-cf-id: QTpDmwYvY2ofQlhL6qtufDdefNtjHqF1Cpsf0lrPIrJ1Bh_-ojivpA== 21:38:16 INFO - x-amz-replication-status: COMPLETED 21:38:16 INFO - x-amz-version-id: nItc4N7jkVCLVV9WB74YzMETQRilTwE. 21:38:17 INFO - Expected file size: 22089727 21:38:17 INFO - Obtained file size: 22089727 21:38:21 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 21:38:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:21 INFO - Http code: 200 21:38:21 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 21:38:21 INFO - x-amz-cf-id: zgyxeJ6tFtQHAf73FxQo8X-XFFu80kx3AzWJjO78ZWxUq0oX9lw7vA== 21:38:21 INFO - x-amz-replication-status: COMPLETED 21:38:21 INFO - x-amz-version-id: nItc4N7jkVCLVV9WB74YzMETQRilTwE. 21:38:21 INFO - Expected file size: 22089727 21:38:21 INFO - Obtained file size: 22089727 21:38:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:38:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:38:26 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:38:26 INFO - Http code: 200 21:38:26 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:38:26 INFO - x-amz-cf-id: -K9aCCa5_sXyIVXeR03cxWc7tWqMVrYWM22a_oUm6VKaCVri6v3Rlw== 21:38:26 INFO - x-amz-replication-status: COMPLETED 21:38:26 INFO - x-amz-version-id: F6hNDoja5kb1EYyKFaijjXk.VIv9D1rV 21:38:26 INFO - Expected file size: 14409028 21:38:26 INFO - Obtained file size: 14409028 21:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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 21:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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 21:38:27 INFO - Downloaded 59493796 bytes. 21:38:27 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:27 INFO - mkdir: /builds/slave/test/properties 21:38:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:27 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:27 INFO - Contents: 21:38:27 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:27 INFO - Running post-action listener: _resource_record_post_action 21:38:27 INFO - Running post-action listener: set_extra_try_arguments 21:38:27 INFO - [mozharness: 2016-10-18 04:38:27.553576Z] Finished download-and-extract step (success) 21:38:27 INFO - [mozharness: 2016-10-18 04:38:27.553802Z] Running populate-webroot step. 21:38:27 INFO - Running pre-action listener: _resource_record_pre_action 21:38:27 INFO - Running main action method: populate_webroot 21:38:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:27 INFO - '--tppagecycles', 21:38:27 INFO - '7'], 21:38:27 INFO - 'tests': ['tsvgm']}}, 21:38:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['damp', 'tps']}, 21:38:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['damp', 'tps']}, 21:38:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['dromaeo_dom']}, 21:38:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['basic_compositor_video']}, 21:38:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:38:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tsvgx', 21:38:27 INFO - 'tsvgr_opacity', 21:38:27 INFO - 'tart', 21:38:27 INFO - 'tscrollx', 21:38:27 INFO - 'cart']}, 21:38:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:27 INFO - 'tsvgr_opacity', 21:38:27 INFO - 'tart', 21:38:27 INFO - 'tscrollx', 21:38:27 INFO - 'cart']}, 21:38:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tp5o']}, 21:38:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['tp5o']}, 21:38:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s', 21:38:27 INFO - '--xperf_path', 21:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:27 INFO - 'tests': ['tp5n']}, 21:38:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--xperf_path', 21:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:27 INFO - 'tests': ['tp5n']}}, 21:38:27 INFO - 'talos.zip': {'path': '', 21:38:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:27 INFO - Running post-action listener: _resource_record_post_action 21:38:27 INFO - [mozharness: 2016-10-18 04:38:27.575671Z] Finished populate-webroot step (success) 21:38:27 INFO - [mozharness: 2016-10-18 04:38:27.575759Z] Running create-virtualenv step. 21:38:27 INFO - Running pre-action listener: _resource_record_pre_action 21:38:27 INFO - Running main action method: create_virtualenv 21:38:27 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:27 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 21:38:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:27 INFO - Using real prefix '/usr' 21:38:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:28 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:30 INFO - Installing pip.................done. 21:38:30 INFO - Return code: 0 21:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:38:30 INFO - Reading from file tmpfile_stdout 21:38:30 INFO - Output received: 21:38:30 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) 21:38:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:38:30 INFO - Using env: {'DISPLAY': ':0', 21:38:30 INFO - 'HOME': '/home/cltbld', 21:38:30 INFO - 'LANG': 'en_US.UTF-8', 21:38:30 INFO - 'LANGUAGE': 'en_US:en', 21:38:30 INFO - 'LOGNAME': 'cltbld', 21:38:30 INFO - 'MAIL': '/var/mail/cltbld', 21:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:30 INFO - 'MOZ_NO_REMOTE': '1', 21:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:30 INFO - 'NO_EM_RESTART': '1', 21:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:30 INFO - 'PWD': '/builds/slave/test', 21:38:30 INFO - 'SHELL': '/bin/bash', 21:38:30 INFO - 'SHLVL': '1', 21:38:30 INFO - 'TERM': 'linux', 21:38:30 INFO - 'TMOUT': '86400', 21:38:30 INFO - 'USER': 'cltbld', 21:38:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:30 INFO - '_': '/tools/buildbot/bin/python'} 21:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:30 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 21:38:30 INFO - Cleaning up... 21:38:30 INFO - Return code: 0 21:38:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:38:30 INFO - Using env: {'DISPLAY': ':0', 21:38:30 INFO - 'HOME': '/home/cltbld', 21:38:30 INFO - 'LANG': 'en_US.UTF-8', 21:38:30 INFO - 'LANGUAGE': 'en_US:en', 21:38:30 INFO - 'LOGNAME': 'cltbld', 21:38:30 INFO - 'MAIL': '/var/mail/cltbld', 21:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:30 INFO - 'MOZ_NO_REMOTE': '1', 21:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:30 INFO - 'NO_EM_RESTART': '1', 21:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:30 INFO - 'PWD': '/builds/slave/test', 21:38:30 INFO - 'SHELL': '/bin/bash', 21:38:30 INFO - 'SHLVL': '1', 21:38:30 INFO - 'TERM': 'linux', 21:38:30 INFO - 'TMOUT': '86400', 21:38:30 INFO - 'USER': 'cltbld', 21:38:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:30 INFO - '_': '/tools/buildbot/bin/python'} 21:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:30 INFO - Downloading/unpacking psutil>=3.1.1 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:32 INFO - Installing collected packages: psutil 21:38:32 INFO - Running setup.py install for psutil 21:38:32 INFO - building 'psutil._psutil_linux' extension 21:38:32 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 21:38:33 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 21:38:33 INFO - building 'psutil._psutil_posix' extension 21:38:33 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 21:38:33 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 21:38:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:33 INFO - Successfully installed psutil 21:38:33 INFO - Cleaning up... 21:38:33 INFO - Return code: 0 21:38:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:38:33 INFO - Using env: {'DISPLAY': ':0', 21:38:33 INFO - 'HOME': '/home/cltbld', 21:38:33 INFO - 'LANG': 'en_US.UTF-8', 21:38:33 INFO - 'LANGUAGE': 'en_US:en', 21:38:33 INFO - 'LOGNAME': 'cltbld', 21:38:33 INFO - 'MAIL': '/var/mail/cltbld', 21:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:33 INFO - 'MOZ_NO_REMOTE': '1', 21:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:33 INFO - 'NO_EM_RESTART': '1', 21:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:33 INFO - 'PWD': '/builds/slave/test', 21:38:33 INFO - 'SHELL': '/bin/bash', 21:38:33 INFO - 'SHLVL': '1', 21:38:33 INFO - 'TERM': 'linux', 21:38:33 INFO - 'TMOUT': '86400', 21:38:33 INFO - 'USER': 'cltbld', 21:38:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:33 INFO - '_': '/tools/buildbot/bin/python'} 21:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:35 INFO - Installing collected packages: mozsystemmonitor 21:38:35 INFO - Running setup.py install for mozsystemmonitor 21:38:35 INFO - Successfully installed mozsystemmonitor 21:38:35 INFO - Cleaning up... 21:38:35 INFO - Return code: 0 21:38:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:35 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:35 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 21:38:35 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 21:38:35 INFO - Using env: {'DISPLAY': ':0', 21:38:35 INFO - 'HOME': '/home/cltbld', 21:38:35 INFO - 'LANG': 'en_US.UTF-8', 21:38:35 INFO - 'LANGUAGE': 'en_US:en', 21:38:35 INFO - 'LOGNAME': 'cltbld', 21:38:35 INFO - 'MAIL': '/var/mail/cltbld', 21:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:35 INFO - 'MOZ_NO_REMOTE': '1', 21:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:35 INFO - 'NO_EM_RESTART': '1', 21:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:35 INFO - 'PWD': '/builds/slave/test', 21:38:35 INFO - 'SHELL': '/bin/bash', 21:38:35 INFO - 'SHLVL': '1', 21:38:35 INFO - 'TERM': 'linux', 21:38:35 INFO - 'TMOUT': '86400', 21:38:35 INFO - 'USER': 'cltbld', 21:38:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:35 INFO - '_': '/tools/buildbot/bin/python'} 21:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:37 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 21:38:37 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 21:38:37 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 21:38:37 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 21:38:37 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 21:38:37 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 21:38:38 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:38 INFO - warning: no files found matching '*.txt' 21:38:38 INFO - no previously-included directories found matching 'build' 21:38:38 INFO - no previously-included directories found matching 'dist' 21:38:38 INFO - no previously-included directories found matching '.git*' 21:38:38 INFO - Installing collected packages: jsonschema, functools32 21:38:38 INFO - Running setup.py install for functools32 21:38:38 INFO - warning: no files found matching '*.txt' 21:38:38 INFO - no previously-included directories found matching 'build' 21:38:38 INFO - no previously-included directories found matching 'dist' 21:38:38 INFO - no previously-included directories found matching '.git*' 21:38:38 INFO - Successfully installed jsonschema functools32 21:38:38 INFO - Cleaning up... 21:38:38 INFO - Return code: 0 21:38:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:38 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')]} 21:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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')]} 21:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:38 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 21:38:38 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 21:38:38 INFO - Using env: {'DISPLAY': ':0', 21:38:38 INFO - 'HOME': '/home/cltbld', 21:38:38 INFO - 'LANG': 'en_US.UTF-8', 21:38:38 INFO - 'LANGUAGE': 'en_US:en', 21:38:38 INFO - 'LOGNAME': 'cltbld', 21:38:38 INFO - 'MAIL': '/var/mail/cltbld', 21:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:38 INFO - 'MOZ_NO_REMOTE': '1', 21:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:38 INFO - 'NO_EM_RESTART': '1', 21:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:38 INFO - 'PWD': '/builds/slave/test', 21:38:38 INFO - 'SHELL': '/bin/bash', 21:38:38 INFO - 'SHLVL': '1', 21:38:38 INFO - 'TERM': 'linux', 21:38:38 INFO - 'TMOUT': '86400', 21:38:38 INFO - 'USER': 'cltbld', 21:38:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:38 INFO - '_': '/tools/buildbot/bin/python'} 21:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:38 INFO - Cleaning up... 21:38:38 INFO - Return code: 0 21:38:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:38 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')]} 21:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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')]} 21:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:38 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 21:38:38 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 21:38:38 INFO - Using env: {'DISPLAY': ':0', 21:38:38 INFO - 'HOME': '/home/cltbld', 21:38:38 INFO - 'LANG': 'en_US.UTF-8', 21:38:38 INFO - 'LANGUAGE': 'en_US:en', 21:38:38 INFO - 'LOGNAME': 'cltbld', 21:38:38 INFO - 'MAIL': '/var/mail/cltbld', 21:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:38 INFO - 'MOZ_NO_REMOTE': '1', 21:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:38 INFO - 'NO_EM_RESTART': '1', 21:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:38 INFO - 'PWD': '/builds/slave/test', 21:38:38 INFO - 'SHELL': '/bin/bash', 21:38:38 INFO - 'SHLVL': '1', 21:38:38 INFO - 'TERM': 'linux', 21:38:38 INFO - 'TMOUT': '86400', 21:38:38 INFO - 'USER': 'cltbld', 21:38:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:38 INFO - '_': '/tools/buildbot/bin/python'} 21:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:40 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:41 INFO - Downloading docopt-0.6.1.tar.gz 21:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:41 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:41 INFO - Running setup.py install for blobuploader 21:38:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:41 INFO - Running setup.py install for requests 21:38:41 INFO - Running setup.py install for docopt 21:38:41 INFO - Successfully installed blobuploader requests docopt 21:38:41 INFO - Cleaning up... 21:38:42 INFO - Return code: 0 21:38:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:42 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 21:38:42 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 21:38:42 INFO - Using env: {'DISPLAY': ':0', 21:38:42 INFO - 'HOME': '/home/cltbld', 21:38:42 INFO - 'LANG': 'en_US.UTF-8', 21:38:42 INFO - 'LANGUAGE': 'en_US:en', 21:38:42 INFO - 'LOGNAME': 'cltbld', 21:38:42 INFO - 'MAIL': '/var/mail/cltbld', 21:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:42 INFO - 'MOZ_NO_REMOTE': '1', 21:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:42 INFO - 'NO_EM_RESTART': '1', 21:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:42 INFO - 'PWD': '/builds/slave/test', 21:38:42 INFO - 'SHELL': '/bin/bash', 21:38:42 INFO - 'SHLVL': '1', 21:38:42 INFO - 'TERM': 'linux', 21:38:42 INFO - 'TMOUT': '86400', 21:38:42 INFO - 'USER': 'cltbld', 21:38:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:42 INFO - '_': '/tools/buildbot/bin/python'} 21:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:42 INFO - Running setup.py (path:/tmp/pip-1ZiICc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:42 INFO - Running setup.py (path:/tmp/pip-zbkLPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:42 INFO - Running setup.py (path:/tmp/pip-y3V1Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:42 INFO - Running setup.py (path:/tmp/pip-xw82wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:42 INFO - Running setup.py (path:/tmp/pip-9ck_sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:42 INFO - Running setup.py (path:/tmp/pip-W5gey5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:42 INFO - Running setup.py (path:/tmp/pip-ixyha6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:42 INFO - Running setup.py (path:/tmp/pip-81sVzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:42 INFO - Running setup.py (path:/tmp/pip-oHnE4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:42 INFO - Running setup.py (path:/tmp/pip-FxsPsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:43 INFO - Running setup.py (path:/tmp/pip-f8x9S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:43 INFO - Running setup.py (path:/tmp/pip-GpOQEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:43 INFO - Running setup.py (path:/tmp/pip-5K8CXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:43 INFO - Running setup.py (path:/tmp/pip-9dmJvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:43 INFO - Running setup.py (path:/tmp/pip-_MO0WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:43 INFO - Running setup.py (path:/tmp/pip-mTtwkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:43 INFO - Running setup.py (path:/tmp/pip-8fVNLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:43 INFO - Running setup.py install for manifestparser 21:38:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:43 INFO - Running setup.py install for mozcrash 21:38:43 INFO - Running setup.py install for mozdebug 21:38:43 INFO - Running setup.py install for mozdevice 21:38:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:43 INFO - Running setup.py install for mozfile 21:38:44 INFO - Running setup.py install for mozhttpd 21:38:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozinfo 21:38:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozInstall 21:38:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozleak 21:38:44 INFO - Running setup.py install for mozlog 21:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for moznetwork 21:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozprocess 21:38:44 INFO - Running setup.py install for mozprofile 21:38:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozrunner 21:38:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:45 INFO - Running setup.py install for mozscreenshot 21:38:45 INFO - Running setup.py install for moztest 21:38:45 INFO - Running setup.py install for mozversion 21:38:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:45 INFO - Cleaning up... 21:38:45 INFO - Return code: 0 21:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:45 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:45 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 21:38:45 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 21:38:45 INFO - Using env: {'DISPLAY': ':0', 21:38:45 INFO - 'HOME': '/home/cltbld', 21:38:45 INFO - 'LANG': 'en_US.UTF-8', 21:38:45 INFO - 'LANGUAGE': 'en_US:en', 21:38:45 INFO - 'LOGNAME': 'cltbld', 21:38:45 INFO - 'MAIL': '/var/mail/cltbld', 21:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:45 INFO - 'MOZ_NO_REMOTE': '1', 21:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:45 INFO - 'NO_EM_RESTART': '1', 21:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:45 INFO - 'PWD': '/builds/slave/test', 21:38:45 INFO - 'SHELL': '/bin/bash', 21:38:45 INFO - 'SHLVL': '1', 21:38:45 INFO - 'TERM': 'linux', 21:38:45 INFO - 'TMOUT': '86400', 21:38:45 INFO - 'USER': 'cltbld', 21:38:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:45 INFO - '_': '/tools/buildbot/bin/python'} 21:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:45 INFO - Running setup.py (path:/tmp/pip-fuGg2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:45 INFO - Running setup.py (path:/tmp/pip-33SiJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:45 INFO - Running setup.py (path:/tmp/pip-E6VKIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:45 INFO - Running setup.py (path:/tmp/pip-YKrBiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:45 INFO - Running setup.py (path:/tmp/pip-85Dtjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:45 INFO - Running setup.py (path:/tmp/pip-ZeNSXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:46 INFO - Running setup.py (path:/tmp/pip-BtC1yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:46 INFO - Running setup.py (path:/tmp/pip-Q59DnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:46 INFO - Running setup.py (path:/tmp/pip-u7tEIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:46 INFO - Running setup.py (path:/tmp/pip-f3fC4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:46 INFO - Running setup.py (path:/tmp/pip-vH2E9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:46 INFO - Running setup.py (path:/tmp/pip-RqHerF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:46 INFO - Running setup.py (path:/tmp/pip-98mKqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:46 INFO - Running setup.py (path:/tmp/pip-gaY0B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:46 INFO - Running setup.py (path:/tmp/pip-QaGlJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:46 INFO - Running setup.py (path:/tmp/pip-h5k97i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:46 INFO - Running setup.py (path:/tmp/pip-1I92G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:48 INFO - Downloading blessings-1.6.tar.gz 21:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:48 INFO - Installing collected packages: blessings 21:38:48 INFO - Running setup.py install for blessings 21:38:48 INFO - Successfully installed blessings 21:38:48 INFO - Cleaning up... 21:38:48 INFO - Return code: 0 21:38:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:49 INFO - Reading from file tmpfile_stdout 21:38:49 INFO - Current package versions: 21:38:49 INFO - argparse == 1.2.1 21:38:49 INFO - blessings == 1.6 21:38:49 INFO - blobuploader == 1.2.4 21:38:49 INFO - docopt == 0.6.1 21:38:49 INFO - functools32 == 3.2.3-2 21:38:49 INFO - jsonschema == 2.5.1 21:38:49 INFO - manifestparser == 1.1 21:38:49 INFO - mozInstall == 1.12 21:38:49 INFO - mozcrash == 0.17 21:38:49 INFO - mozdebug == 0.1 21:38:49 INFO - mozdevice == 0.48 21:38:49 INFO - mozfile == 1.2 21:38:49 INFO - mozhttpd == 0.7 21:38:49 INFO - mozinfo == 0.9 21:38:49 INFO - mozleak == 0.1 21:38:49 INFO - mozlog == 3.4 21:38:49 INFO - moznetwork == 0.27 21:38:49 INFO - mozprocess == 0.23 21:38:49 INFO - mozprofile == 0.28 21:38:49 INFO - mozrunner == 6.12 21:38:49 INFO - mozscreenshot == 0.1 21:38:49 INFO - mozsystemmonitor == 0.3 21:38:49 INFO - moztest == 0.7 21:38:49 INFO - mozversion == 1.4 21:38:49 INFO - psutil == 3.1.1 21:38:49 INFO - requests == 1.2.3 21:38:49 INFO - wsgiref == 0.1.2 21:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:49 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')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:49 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 21:38:49 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 21:38:49 INFO - Using env: {'DISPLAY': ':0', 21:38:49 INFO - 'HOME': '/home/cltbld', 21:38:49 INFO - 'LANG': 'en_US.UTF-8', 21:38:49 INFO - 'LANGUAGE': 'en_US:en', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MAIL': '/var/mail/cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SHLVL': '1', 21:38:49 INFO - 'TERM': 'linux', 21:38:49 INFO - 'TMOUT': '86400', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - '_': '/tools/buildbot/bin/python'} 21:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38:49 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')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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 0x7fc446cb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, '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-1476765494.175293-1238792284', '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 21:38:49 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 21:38:49 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 21:38:49 INFO - Using env: {'DISPLAY': ':0', 21:38:49 INFO - 'HOME': '/home/cltbld', 21:38:49 INFO - 'LANG': 'en_US.UTF-8', 21:38:49 INFO - 'LANGUAGE': 'en_US:en', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MAIL': '/var/mail/cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SHLVL': '1', 21:38:49 INFO - 'TERM': 'linux', 21:38:49 INFO - 'TMOUT': '86400', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - '_': '/tools/buildbot/bin/python'} 21:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Running post-action listener: _resource_record_post_action 21:38:49 INFO - Running post-action listener: _start_resource_monitoring 21:38:49 INFO - Starting resource monitoring. 21:38:49 INFO - [mozharness: 2016-10-18 04:38:49.675071Z] Finished create-virtualenv step (success) 21:38:49 INFO - [mozharness: 2016-10-18 04:38:49.675604Z] Running install step. 21:38:49 INFO - Running pre-action listener: _resource_record_pre_action 21:38:49 INFO - Running main action method: install 21:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:49 INFO - Reading from file tmpfile_stdout 21:38:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:49 INFO - Reading from file tmpfile_stdout 21:38:49 INFO - Output received: 21:38:49 INFO - Usage: mozinstall [options] installer 21:38:49 INFO - Options: 21:38:49 INFO - -h, --help show this help message and exit 21:38:49 INFO - -d DEST, --destination=DEST 21:38:49 INFO - Directory to install application into. [default: 21:38:49 INFO - "/builds/slave/test"] 21:38:49 INFO - --app=APP Application being installed. [default: firefox] 21:38:49 INFO - mkdir: /builds/slave/test/build/application 21:38:49 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'] 21:38:49 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 21:39:06 INFO - Reading from file tmpfile_stdout 21:39:06 INFO - Output received: 21:39:06 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:06 INFO - Running post-action listener: _resource_record_post_action 21:39:06 INFO - [mozharness: 2016-10-18 04:39:06.914484Z] Finished install step (success) 21:39:06 INFO - [mozharness: 2016-10-18 04:39:06.914761Z] Running run-tests step. 21:39:06 INFO - Running pre-action listener: _resource_record_pre_action 21:39:06 INFO - Running main action method: run_tests 21:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:06 INFO - Python 2.7.3 21:39:06 INFO - Return code: 0 21:39:06 INFO - grabbing minidump binary from tooltool 21:39: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')]} 21:39:06 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 0x1adf930>, '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 0x1ae0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:06 INFO - Return code: 0 21:39:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:39:06 INFO - Using env: {'DISPLAY': ':0', 21:39:06 INFO - 'HOME': '/home/cltbld', 21:39:06 INFO - 'LANG': 'en_US.UTF-8', 21:39:06 INFO - 'LANGUAGE': 'en_US:en', 21:39:06 INFO - 'LOGNAME': 'cltbld', 21:39:06 INFO - 'MAIL': '/var/mail/cltbld', 21:39:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:06 INFO - 'MOZ_NO_REMOTE': '1', 21:39:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:07 INFO - 'NO_EM_RESTART': '1', 21:39:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:07 INFO - 'PWD': '/builds/slave/test', 21:39:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:07 INFO - 'SHELL': '/bin/bash', 21:39:07 INFO - 'SHLVL': '1', 21:39:07 INFO - 'TERM': 'linux', 21:39:07 INFO - 'TMOUT': '86400', 21:39:07 INFO - 'USER': 'cltbld', 21:39:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476765494.175293-1238792284', 21:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:07 INFO - '_': '/tools/buildbot/bin/python'} 21:39:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:39:07 INFO - mozversion application_buildid: 20161017183007 21:39:07 INFO - mozversion application_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 21:39:07 INFO - mozversion application_display_name: Nightly 21:39:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:07 INFO - mozversion application_name: Firefox 21:39:07 INFO - mozversion application_remotingname: firefox 21:39:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:39:07 INFO - mozversion application_vendor: Mozilla 21:39:07 INFO - mozversion application_version: 52.0a1 21:39:07 INFO - mozversion platform_buildid: 20161017183007 21:39:07 INFO - mozversion platform_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 21:39:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:39:07 INFO - mozversion platform_version: 52.0a1 21:39:07 INFO - using testdate: 1476765547 21:39:07 INFO - actual date: 1476765547 21:39:07 INFO - starting webserver on 'localhost:54697' 21:39:07 INFO - SUITE-START | Running 2 tests 21:39:07 INFO - TEST-START | dromaeo_css 21:39:07 INFO - operating with platform_type : linux_ 21:39:07 INFO - Initialising browser for dromaeo_css test... 21:39:07 INFO - TEST-INFO | started process 14404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdMklq0/profile http://localhost:54697/getInfo.html) 21:39:11 INFO - PROCESS | 14404 | __metrics Screen width/height:1600/1200 21:39:11 INFO - PROCESS | 14404 | colorDepth:24 21:39:11 INFO - PROCESS | 14404 | Browser inner width/height: 1024/697 21:39:11 INFO - PROCESS | 14404 | __metrics 21:39:11 INFO - PROCESS | 14404 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:39:11 INFO - PROCESS | 14404 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:39:12 INFO - PROCESS | 14404 | console.error: PushService: 21:39:12 INFO - PROCESS | 14404 | stateChangeProcessEnqueue: Error transitioning state 21:39:12 INFO - PROCESS | 14404 | UnknownError 21:39:13 INFO - TEST-INFO | 14404: exit 0 21:39:13 INFO - Browser initialized. 21:39:13 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:13 INFO - TEST-INFO | started process 14487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdMklq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:25 INFO - PROCESS | 14487 | RSS: Main: 172421120 21:39:25 INFO - PROCESS | 14487 | 21:40:16 INFO - PROCESS | 14487 | 1476765616990 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] 21:42:26 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54697/tests/dromaeo/cssquery-ext.html) 21:42:29 INFO - PROCESS | 14487 | RSS: Main: 398893056 21:42:29 INFO - PROCESS | 14487 | 21:45:32 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-ext.html (next: http://localhost:54697/tests/dromaeo/cssquery-jquery.html) 21:45:32 INFO - PROCESS | 14487 | RSS: Main: 283160576 21:45:32 INFO - PROCESS | 14487 | 21:48:34 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54697/tests/dromaeo/cssquery-mootools.html) 21:48:35 INFO - PROCESS | 14487 | RSS: Main: 220577792 21:48:35 INFO - PROCESS | 14487 | 21:51:37 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54697/tests/dromaeo/cssquery-prototype.html) 21:51:37 INFO - PROCESS | 14487 | RSS: Main: 257232896 21:51:37 INFO - PROCESS | 14487 | 21:54:40 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54697/tests/dromaeo/cssquery-yui.html) 21:54:41 INFO - PROCESS | 14487 | RSS: Main: 220176384 21:54:41 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:54697/tests/dromaeo/cssquery-yui.html (next: http://localhost:54697/tests/dromaeo/cssquery-dojo.html) 21:57:44 INFO - PROCESS | 14487 | RSS: Main: 314732544 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | __start_tp_report 21:57:44 INFO - PROCESS | 14487 | _x_x_mozilla_page_load 21:57:44 INFO - PROCESS | 14487 | _x_x_mozilla_page_load_details 21:57:44 INFO - PROCESS | 14487 | |i|pagename|runs| 21:57:44 INFO - PROCESS | 14487 | |0;dojo.html;2916.08143434818;2943.3818898031413;2971.628546431696;2973.21209879382;2984.089852594958;5052.772625231864;5195.246689230059;5202.531772140506;5271.525562699357;5383.273258110149;5180.689158650474;5231.476852314767;5328.120860058086;5344.4922732340465;5373;4820.734859582722;4844.515548445145;4851.854444366674;4854.17479028566;4872.147374209517;4866.294387313837;4876;4955.826546070888;4961.528654777809;5006.424261209952;4886.828960986349;4902.3872015998;4948.925766113512;4962.5533701966815;5004.474530174334;4617.653675974282;4682.250839865639;4686.625069994427;4689.742064186468;4780.784864681063;4765.976170119162;4776.0925424169645;4789.640776941744;4808.278758186265;4835.540623640749;5311.389190243094;5319.893602127974;5323.893522129536;5337.759800808973;5362.168863826113;5376.811811586615;5414.3232095988005;5445.1832225166145;5675.347335056439;5679.687617181054;5616.354119276254;5621.381648018714;5628.04323265046;5636.774529018834;5715.628484148517;5275.208718692188;5286.7092309922555;5287.947120528823;5288.603354748409;5340.732963351817;5497.175423686399;5538.47384498472;5555.833325000256;5724.599278050497;5736.856578585569;5391.433899440581;5486.1222204447095;5538.47384498472;5594.021046316879;5598.076317407664;5567.137093750475;5610.579206559524;5614.494695477427;5615.6630602164005;5679.119736440858;5593.216949627055;5603.103503439512;5603.271574695264;5605.047141985872;5605.523530499871;5364.6512976656395;5441.265429167091;5447.5641948644015;5504.944950550524;5655.604107712421;4235.25882970479;4258.318669012943;4264.019275566575;4270.7010509264055;4271.273883439822;3862.1696335288048;3863.130795570974;3865.9226815463535;3867.535895692479;3869.5550011748446;5190.688558686491;5193.246979187997;5193.246979188072;5195.376554813447;5196.844094677166;5487.4238204987905;5487.64330318528;5489.917651235235;5489.945100548944;5504.2018907258225;5185.637005409585;5189.42916279209;5191.195364718475;5191.428942816287;5191.6884986900905;4843.782029808667;4938.111139994836;4938.851834444972;4942.975285123552;4953.925691114636;5864.765409383662;5874.794382196603;5875.471207591338;5877.38287479817;5884.735186916599;5407.513323800719;5460.34475862899;5685.971570142123;5693.345265294544;5760.510356619734;5661.207430959751;5787.131930210502;5788.884222315614;5792.1311803229855;5862.501687356623;5520.033994051106;5520.254765606592;5522.641028333145;5523.861903452285;5532.253145825262;5436.728163591725;5597.63615365;5602.3837377887585;5607.439256074523;5610.410906854721;5364.329458817648;5430.5384042356845;5444.156155795858;5444.50999410055;5449.6730196188355;5298;5411.891762164813;5418.539424148834;5420.647657902224;5425.321834770653;5360.142377219626;5367.248585198154;5378.1663842104535;5379.004884096455;5381.865453363697;5415.6479828811;5448.128299472065;5449.3460784706085;5466.753996070266;5469.206964990134;5321.787128514816;5347.251384806053;5348.358197016383;5352.197170424468;5353.304070470814 21:57:44 INFO - PROCESS | 14487 | |1;ext.html;572.0532518681581;596.6062398816779;604.7067172421372;609.8566836793353;623.5136593457103;41308.17383652325;43171.13657726844;43360.783196083976;43412.782936085314;46058;43731.12537749243;44276.557234427644;44293.33559996603;44313.7784311078;44324.556754432444;7900.525968441883;8056.798580035516;8516.446430981981;8625.525596092244;8637;10233.232507561963;10488;10499.370037797718;10869.891301086967;10884.07485363745;10718.196135289845;10783.352998820057;10794.46027698616;10800.72998175044;10800.837987430155;10599.258051936367;10640.893591064107;10674.839877401846;10680.732981675443;10684.465776711173;10429.947850260776;10516.158707303397;10518.474076296232;10518.631847885288;10520.579176832918;40050.399244011365;40404.393934091015;40436.59563404358;40590.39114413286;40635.796821015705;2780.7497325240824;2797.482465743844;2864.1264414353614;2905.694902035298;2910.738033576988;30592.694073059207;31089.37821243585;31107;31326.530102048488;31573.526397104062;3442.913927151816;3455.930881382358;3487.407140786047;3515.8945231643092;3626.2203626220225;300452;300781;301996.4900175507;302026;302565;55327.72336138294;55741;55963.720181398836;55969.44030559642;56076.43923560712;36243.81878090592;37160;37282.44076338857;37304.44043339298;60114.39885601088;16334.509964701077;16453;16479.83520164783;16495.257713402927;16498.505044848673;11444.942775286238;11745;12120.27278363301;12202.38988050594;12454.25274483534;18625.53436164107;18634.81365186358;18647.44057678272;18742.437726868215;18754.718679219823;6907.0883282489785;7019.227884932653;7174.426045916419;7176.174739904874;7211.747588834365;895.6283142495921;989.7970915962211;1040.2250323509033;1061.2412125330425;1086.071408945356;29657.85171074131;31139.84430077835;31242;31538;31742.841285793424;1043.780806030742;1096.6709987004026;1108.7172770943357;1131.9868717497793;1139.3790384240608;15847.920760396124;16717.414890478776;16773;16786.328546858233;17088.487345379657;515028;522950;525550;802917;806213;57435.425645743846;57790.7110464445;57864.42135578675;58072.70963645239;58154.127688084714;1182.760371554024;1242.043626407679;1291.6770807298176;1304.5564508067303;1332.0875200487696;27500.449990999667;32393.514097288087;32516.18709532186;32565.837170813993;32832.67167328296;49481.50518494769;50152;50161.49838501714;50204;50221.74889125531;405329;410216.46752986097;410820;410982;411429.45702331;26705.19884403471;27135.5075470851;27343.726562734915;28413.857930710215;28417.43165136727;45804.77097614491;46731.29903051525;46732.53267467282;46973.295400568335;47100.7644961773;38399.80800095982;38947;39023;39332.606673932896;40026.59973400229;38950.220995580494;39117.804410978904;39120.21759564849;39447.80276098716;41045;39438;40044.199116016935;41549.584504155784;42528.14943701047;45297.320540191264;37398.626013739515;41817.16365672609;42070.36894446647;42354;42723.3591496134;30979.225519362197;32885.50671739974;33267;33501;33537.66462335443 21:57:44 INFO - PROCESS | 14487 | |2;jquery.html;341.15646089841175;357.9176789338452;365.384327408317;370.64233015140394;385.7531180044772;13936.721265574695;17666.470005899828;18377.816221837795;18809.811901880978;19894;17300.740488892676;17321.480355589352;17584.82415175848;17818.554536136602;18387.356442524513;4851.781669824857;5153.6392452528335;5158.097332966735;5162.432132465445;5166.793328266865;3785.299719551878;3823.8661646842365;5088.236764485338;5165.199394093903;5165.7158856262895;4211.220924129046;4314.3097104463295;6393.424591786738;6403;6417.422431981121;6190.350013248589;6338;6427.068075129104;6431.260405053432;6442.387973142544;5613.4386561343945;5618;5624.91562626561;5625.578081643852;5625.634333768333;21401.67897481539;21456.14175432981;21486.57026859454;21853;22027;2051.2307884543297;2103.5582527669208;2177.6760843613274;2192.4299682082615;2888.7544558712534;8780.912190878073;8848.292136629054;8953.955230223872;9191.35660503765;9244.815103697889;1742.3466200174935;1754.6227561074302;1833.8532917366579;1844.62185252023;1863.506170864722;70069.64965175193;74766;75142;76159.99999999945;77427;9956.103950644478;10093.091621754078;10174.389536627827;10216.642417515352;10251.12865406434;13962.58112256634;13963.511277105456;13967.720645587031;13977.3710183042;14003;7486.43851711113;7656.525584207318;7686;7705.267999540035;7897.605119744105;7402.1117465904435;7459.254074592497;7632.503887247422;7676.692932282646;7718.035245594301;4130.690198235145;4266.978665106717;4308.332208507686;4412.779361031936;4423.800928958204;1693.2126561149125;1740.904250266222;1767.5669460982142;1776.5736223306315;1787.052861983125;912.8767616371838;948.8766460360109;973.3040875773855;1003.1022235099545;1009.8737657792776;17249.706272029398;18713;18823.90588047051;19097.140628671743;19233.326833560757;916.706653870755;939.5912777941618;972.8783902012249;994.7761753605381;1004.8743907011624;9882.357646752938;10570.418626975435;10604.522796474022;10674.839877401846;10692.732681682864;439729;457499;461381;482515;483698;79845.60077199577;80658.59670701726;81516.18483815086;81558;82172.17827821765;965.7199412170391;978.7748817771952;980.7302991677345;984.9753756156153;994.2990191914682;15708.60728481797;15827.208639568205;15934.9203253983;15991.280392382603;16960.660786784443;38826.2234755309;39090.80454597709;40154;40640.73272306365;40897.59102408938;48644.270335945694;48786;52134.47865521296;52332.73833630807;53662.46337536575;7588.962055189689;7630;7657.923420765721;7756.224377562198;7850.6074696266105;9339.859902101338;12302.200356976768;12499.500019999461;12606.810897836356;12692.619221423372;10632.734181645521;10712.946435267773;10960.9722201393;11177.832332515181;11428.428578570873;10486.161107111566;10553.525091370753;10575.841362379724;10667.89332106669;10818.026377625736;10940.507677154706;11118.277311974696;11253.606123785628;11313.71715707114;11748.70628234301;7921.207879212263;7934.127246002819;7994.801429606905;8102;8114;8011.118776934649;10862.511186996762;10974.725631859268;11013.779724405627;11193.705290415282 21:57:44 INFO - PROCESS | 14487 | |3;mootools.html;1297.0985165310112;1441.5170917742555;1501.1443477217983;1616.7332390155625;1787.9821201787986;7466.51467654602;8424.283935865451;8687.08785577514;8689.91310086899;8870.423422477534;8676.652933882653;8749.69376071836;8752.606132724026;8765.254953328958;8765.47407155571;2240.0367841828006;2257.480779420734;2266.286119872243;2268.875211863347;2271.909123635061;2157.7194964654573;2206.58074965756;2207.6467765157577;2214.1586197245024;2217.7782221777857;2241.5628952354296;2244.461329280969;2247.4606094537357;2250.3923940536047;2278.646809744492;2230.8438409311357;2248.9325320240337;2253.188852013274;2258.4692597239555;2261;2181.7709140540333;2186.8797216153107;2191.6712493126;2191.835612329082;2215.4682876109778;8579.742607721715;8610;8687.131286871325;8694.652213911437;8705;4917.950820491821;5054.721990290533;5055.9241611375855;5104.974475127638;5106.64253502255;3231.0952933178746;3406.5230867678547;3422.931541369159;3474.9305013899834;3478.826058697055;958.8849338079406;1019.2253887045824;1032.3135115148418;1033.7260625934134;1058.4072919165292;11531.308121512737;11587.826182607268;11617.94191029048;11705.765884682258;11718.945294923413;4069.084455997436;4139.441175441337;4273.18809426208;4283.2932566126865;4293;9219.308551858638;9302.906970930204;9305.25557955362;9315.906840931504;9317.16145546904;4886.340344053508;4899.167141585939;4901.485344038896;4902.90194196114;4906.190478571068;4057.087155390014;4178.143480586473;4356.281213599784;4540.704854184468;4551.635869130461;3577.069961809896;3650.926981460356;3745.850165993384;3767.56672982605;3769.8869033929027;1080.5245691895698;1117.742919128605;1136.5737848306885;1140.2303445174473;1145.2841973766397;798.7084714079319;821.9383546234056;904.9638014479478;909.4634165842185;917.0691747875911;5311.442298558596;5510.118381059011;5614.775408983676;5631.633943793722;5814.389489103583;843.6751850537587;890.6481939633809;935.555611084743;944.593824655391;958.4680502321139;3466.665333846487;3695.963040369562;3829.4064420014943;3847.730658853853;3859.729818912649;10882;10941.28881622692;11042.723931901766;11062.668119956414;11140.275882067639;10887.945560272148;10936.56253749841;10938.234323597271;10997.505112269808;11023.889761102446;7646;7934.603269836485;8025.719099831478;8029.397795165386;8170.264676179172;5588.2455868458865;5672;5715.571332150189;5721.57088218377;5930.347661757117;9560.76098097553;9570.282228833004;9978.451185184884;10029.147522460673;10114.039166279192;9810;9936.105750482491;10230.539625717009;10230.795384092426;10301.227407944285;6568.770093046721;6887.793366199022;7149.53528020677;7311.780646580399;7313.341799237881;8075.071366792894;8301.377396695152;8328.958355208186;8344.58277086131;8362.707305244287;7246.094238220223;7338.596377199306;7440.73957411488;7442.665080071518;7534.133574638768;7076.964615176891;7102.964485177541;7124.109486314211;7164.176119746296;7210.567365958059;6241.469475094668;6309.621422714468;6349.841253968688;6378.808635740936;6400.295967443671;4673.789679464364;4710.222813235915;4742.241241401359;4748.0978614063215;4848.612111031039;4612.100640375094;4662.417197850269;4683;4693.131770622445;4694.718316900997 21:57:44 INFO - PROCESS | 14487 | |4;prototype.html;293.9970600293998;297.3962855403531;305.97093276138776;306.5616168878503;312.596750192252;5148.588112950964;5244.292020577221;5286.762095705692;5322.467753224681;5369.436209198032;5133.845984620468;5207.609429292808;5217.426083130853;5299.788008479656;5306.91208302298;4131.8553850615235;4151.564085770996;4165.229777344632;4172.436721042651;4172.52016018158;3913.6086391360923;4070.450489183952;4135.214309281242;4172.666186705056;4190.28765109932;4056.5132184137947;4058.9594104059024;4064.146529228851;4064.634182923536;4066.8169932352966;4038.737482063686;4048.2308361411237;4052.7365721228175;4054.0270335119358;4054.493188351456;3535.9116022099397;3537.858485660596;3544.0962554548682;3547.255076433952;3551.254236610315;5080.288759573663;5107.744612769384;5124.564412024945;5129.512696293846;5160.122779127557;4593.219152744042;4599.816007359702;4606.26299792035;4607.516210797851;4615.584597386218;5466.699331536764;5476.972615136939;5478.972605136949;5481.451854814526;5506.339239291271;3776.66010059096;3848.1726428817938;3872.341701910682;3881.3013657541633;3883.203943191639;5700.971495142539;5720.141978703186;5750.482456578928;5755.510781583571;5756.884862302731;3960.2871483133313;3969.583193764613;3969.861054863066;3985.880423587297;4010.438538604598;3842.2315536892734;4002.399640054015;4010.5588385277597;4052.4326594276827;4058.1680755445063;4606.539346065367;4613.861584152481;4624.26011838111;4633.606143477842;4639.976800115978;5551.72241387929;5557.944420555743;5559.77760889568;5574.247476590608;5590.273264475592;1269.8984081273477;1289.5744404346542;1301.7266374061364;1315.283170671986;1366.3646404421793;823.6952327638812;849.6363336844399;850.9319254459629;853.9316854651613;858.6994551906907;4688.929666055012;4705.223638099676;4712.818847278074;4723.913499895043;4743.810247590127;4910.312556242129;4910.754462276872;4941.407031156285;4945.604351651859;4950.777215025332;4655.348251244828;4657.836975705834;4701.670883038155;4710.764461776897;4728.290756386569;2804.2568719288997;2992.940141197164;3024.941270555288;3026.379592183597;3027.3188532579993;5846.473817356458;5855.853603659943;5872.324682661549;5884.264466941632;5893.086571581412;5472.425395333512;5707.686077265707;5747.511461525817;5821.505172060338;5843;5806.564507661942;5806.751548417111;5811.273590801235;5821.27234095738;5821.563382746395;5622.409646987007;5663.187779910554;5678.659280443187;5697.601167918206;5732.226149469935;5296.576273898002;5612.5509959202345;5638.520725738194;5639.210510528611;5646.3788983212635;5884.7940322088525;5887.292685121267;5891.525559265205;5901.29184497863;5938.257717785277;3841.6926645867707;3889.969158173143;3904.613862078921;3923.2545816294814;3930.80345982694;5687.658740475585;5699;5712.171735098471;5734.050422856249;5740.512056475246;5310.707911064928;5439.292891924025;5466.835994920159;5596.916046259391;5616.69108199053;5528.391876893458;5572.582056345709;5572.91640625399;5573.498385145356;5595.552355811444;5326.174442961347;5459.808906688247;5478.233047373291;5505.559555235492;5578.693171875586;5545.805896793754;5569.721513924206;5577.553795696415;5581.5813813963305;5605.271314729059;5454.727263636882;5462.726863656721;5515.338159420895;5539.556835453234;5552.278793574005 21:57:44 INFO - PROCESS | 14487 | |5;yui.html;573.3234782956112;613.7268915332677;624.1490006658914;627.2191122053044;639.9776007839727;13619.591412257623;14227.146371217708;14321.78517322241;14326.212058336787;14328.570142895704;13064.804027939588;13163.07858449909;13212.735745285088;13274.867251327483;13285.269310187936;632.4529282170912;769.0924708843562;789.2738680414033;792.2671528835832;793.2067932067932;661.6592454885738;782.8395178988322;804.1556365815899;804.2118723650826;812.1675282835082;848.8641817309232;850.8128211793427;852.8635418333068;853.0957185383483;853.4537895746727;835.9665613375457;837.3426859914938;837.417994493827;840.9453385529952;843.304273973974;618.9257289125288;622.2346513788066;627.4008322052429;627.6861569215392;628.2398298059354;12720.61838144848;12871.22772633645;12889.162204456774;12893.033022523254;12895.355232238351;11953.103517236243;12084.104892180883;12629.2422454653;12839.358032098358;13484.325783710776;9722.513874306256;9894.703158905244;10050.547725352377;10057.346272492265;10512.632057877938;3430.2281986553076;3456.343294773985;3479.0780443182575;3484.0767196692896;3599.784012959231;75121.99008145947;75804;76539.61730191369;76750.6162469184;78275.6086219571;9084.454932703928;9194.90805091954;9371.812563748686;9592.136707696342;9690.321677482509;21848.89075554612;21896;21905;21923.342299731034;22005.889970550044;6657.667116644246;6900.896486552706;6998.125234345707;7104.502684812013;7524.736634217776;3948.6643635290748;4077.041895154636;4181.560936101726;4221.008063105168;4252.681048921343;3122.953155702666;3271.8036917785007;3274.6070471543567;3279.8032118072992;3307.9007629770663;539.1023945131391;543.4918351341508;550.754914063246;556.1935193968761;560.1289994059196;565.5164834066895;571.180356188862;587.2453896742666;602.7317843559574;632.9366664004425;7586.544807311579;7894.723684671124;8309;8350.33197344211;8401.873971890427;475.97858096385744;498.41685228282995;533.1789044870856;577.794882816594;609.1928195141455;3794.962050379461;3797.487339209227;3943.211357728466;3966.7619942803526;4068.959310406917;110974;111950.44024779987;112282.43858780654;114855.42572287252;117334.41332793281;78857.21142788499;97162;98395.50802245943;99692.5015374933;100929;85916.57041714876;88609;89496.5525172383;91344;91632.08367916502;7243.311885370881;7439.107307123179;7442.441816863865;7574.545527268381;7843.176466471166;49641;49796;51346.48653513417;51495.74252128715;53343.39667909503;69472;73199;74490.62754686191;75341.6232918832;75960.24039759532;8774.556780067;8985.595648195978;9177.174054335143;9355.766105847137;9559.091886270793;10442.530086146293;10450.843237351293;10531.526081326205;10637.042666160083;10673.146148307962;9628.085331893459;9713.271504637321;9927.950360248153;9962.712304939208;10272.024157705006;9820.361676491006;10177.338472999232;10296.124829389586;10615.256932014685;10690.518926648476;9708.5145742714;9997.750056248651;10284.911777449139;10368.066873981377;10484.217682993756;8010.879836802569;8105.554194519123;8174.468659537111;8646.394752367274;8796.340274479311;7647.885281720667;7682.270184332479;8290.626921788655;8724.825503489768;8944.552772361487 21:57:44 INFO - PROCESS | 14487 | __end_tp_report 21:57:44 INFO - PROCESS | 14487 | __start_cc_report 21:57:44 INFO - PROCESS | 14487 | _x_x_mozilla_cycle_collect,2483 21:57:44 INFO - PROCESS | 14487 | __end_cc_report 21:57:44 INFO - PROCESS | 14487 | __startTimestamp1476766664410__endTimestamp 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | ------- Summary: start ------- 21:57:44 INFO - PROCESS | 14487 | Number of tests: 6 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#0] dojo.html Cycles:165 Average:5199.00 Median:5367.25 stddev:580.76 (10.8%) stddev-sans-first:554.24 21:57:44 INFO - PROCESS | 14487 | Values: 2916.1 2943.4 2971.6 2973.2 2984.1 5052.8 5195.2 5202.5 5271.5 5383.3 5180.7 5231.5 5328.1 5344.5 5373.0 4820.7 4844.5 4851.9 4854.2 4872.1 4866.3 4876.0 4955.8 4961.5 5006.4 4886.8 4902.4 4948.9 4962.6 5004.5 4617.7 4682.3 4686.6 4689.7 4780.8 4766.0 4776.1 4789.6 4808.3 4835.5 5311.4 5319.9 5323.9 5337.8 5362.2 5376.8 5414.3 5445.2 5675.3 5679.7 5616.4 5621.4 5628.0 5636.8 5715.6 5275.2 5286.7 5287.9 5288.6 5340.7 5497.2 5538.5 5555.8 5724.6 5736.9 5391.4 5486.1 5538.5 5594.0 5598.1 5567.1 5610.6 5614.5 5615.7 5679.1 5593.2 5603.1 5603.3 5605.0 5605.5 5364.7 5441.3 5447.6 5504.9 5655.6 4235.3 4258.3 4264.0 4270.7 4271.3 3862.2 3863.1 3865.9 3867.5 3869.6 5190.7 5193.2 5193.2 5195.4 5196.8 5487.4 5487.6 5489.9 5489.9 5504.2 5185.6 5189.4 5191.2 5191.4 5191.7 4843.8 4938.1 4938.9 4943.0 4953.9 5864.8 5874.8 5875.5 5877.4 5884.7 5407.5 5460.3 5686.0 5693.3 5760.5 5661.2 5787.1 5788.9 5792.1 5862.5 5520.0 5520.3 5522.6 5523.9 5532.3 5436.7 5597.6 5602.4 5607.4 5610.4 5364.3 5430.5 5444.2 5444.5 5449.7 5298.0 5411.9 5418.5 5420.6 5425.3 5360.1 5367.2 5378.2 5379.0 5381.9 5415.6 5448.1 5449.3 5466.8 5469.2 5321.8 5347.3 5348.4 5352.2 5353.3 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#1] ext.html Cycles:180 Average:60387.72 Median:3501.65 stddev:127381.59 (3637.8%) stddev-sans-first:127659.76 21:57:44 INFO - PROCESS | 14487 | Values: 572.1 596.6 604.7 609.9 623.5 41308.2 43171.1 43360.8 43412.8 46058.0 43731.1 44276.6 44293.3 44313.8 44324.6 7900.5 8056.8 8516.4 8625.5 8637.0 10233.2 10488.0 10499.4 10869.9 10884.1 10718.2 10783.4 10794.5 10800.7 10800.8 10599.3 10640.9 10674.8 10680.7 10684.5 10429.9 10516.2 10518.5 10518.6 10520.6 40050.4 40404.4 40436.6 40590.4 40635.8 2780.7 2797.5 2864.1 2905.7 2910.7 30592.7 31089.4 31107.0 31326.5 31573.5 3442.9 3455.9 3487.4 3515.9 3626.2 300452.0 300781.0 301996.5 302026.0 302565.0 55327.7 55741.0 55963.7 55969.4 56076.4 36243.8 37160.0 37282.4 37304.4 60114.4 16334.5 16453.0 16479.8 16495.3 16498.5 11444.9 11745.0 12120.3 12202.4 12454.3 18625.5 18634.8 18647.4 18742.4 18754.7 6907.1 7019.2 7174.4 7176.2 7211.7 895.6 989.8 1040.2 1061.2 1086.1 29657.9 31139.8 31242.0 31538.0 31742.8 1043.8 1096.7 1108.7 1132.0 1139.4 15847.9 16717.4 16773.0 16786.3 17088.5 515028.0 522950.0 525550.0 802917.0 806213.0 57435.4 57790.7 57864.4 58072.7 58154.1 1182.8 1242.0 1291.7 1304.6 1332.1 27500.4 32393.5 32516.2 32565.8 32832.7 49481.5 50152.0 50161.5 50204.0 50221.7 405329.0 410216.5 410820.0 410982.0 411429.5 26705.2 27135.5 27343.7 28413.9 28417.4 45804.8 46731.3 46732.5 46973.3 47100.8 38399.8 38947.0 39023.0 39332.6 40026.6 38950.2 39117.8 39120.2 39447.8 41045.0 39438.0 40044.2 41549.6 42528.1 45297.3 37398.6 41817.2 42070.4 42354.0 42723.4 30979.2 32885.5 33267.0 33501.0 33537.7 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#2] jquery.html Cycles:180 Average:27057.19 Median:22514.14 stddev:76539.82 (340.0%) stddev-sans-first:76728.24 21:57:44 INFO - PROCESS | 14487 | Values: 341.2 357.9 365.4 370.6 385.8 13936.7 17666.5 18377.8 18809.8 19894.0 17300.7 17321.5 17584.8 17818.6 18387.4 4851.8 5153.6 5158.1 5162.4 5166.8 3785.3 3823.9 5088.2 5165.2 5165.7 4211.2 4314.3 6393.4 6403.0 6417.4 6190.4 6338.0 6427.1 6431.3 6442.4 5613.4 5618.0 5624.9 5625.6 5625.6 21401.7 21456.1 21486.6 21853.0 22027.0 2051.2 2103.6 2177.7 2192.4 2888.8 8780.9 8848.3 8954.0 9191.4 9244.8 1742.3 1754.6 1833.9 1844.6 1863.5 70069.6 74766.0 75142.0 76160.0 77427.0 9956.1 10093.1 10174.4 10216.6 10251.1 13962.6 13963.5 13967.7 13977.4 14003.0 7486.4 7656.5 7686.0 7705.3 7897.6 7402.1 7459.3 7632.5 7676.7 7718.0 4130.7 4267.0 4308.3 4412.8 4423.8 1693.2 1740.9 1767.6 1776.6 1787.1 912.9 948.9 973.3 1003.1 1009.9 17249.7 18713.0 18823.9 19097.1 19233.3 916.7 939.6 972.9 994.8 1004.9 9882.4 10570.4 10604.5 10674.8 10692.7 439729.0 457499.0 461381.0 482515.0 483698.0 79845.6 80658.6 81516.2 81558.0 82172.2 965.7 978.8 980.7 985.0 994.3 15708.6 15827.2 15934.9 15991.3 16960.7 38826.2 39090.8 40154.0 40640.7 40897.6 48644.3 48786.0 52134.5 52332.7 53662.5 7589.0 7630.0 7657.9 7756.2 7850.6 9339.9 12302.2 12499.5 12606.8 12692.6 10632.7 10712.9 10961.0 11177.8 11428.4 10486.2 10553.5 10575.8 10667.9 10818.0 10940.5 11118.3 11253.6 11313.7 11748.7 7921.2 7934.1 7994.8 8102.0 8114.0 8011.1 10862.5 10974.7 11013.8 11193.7 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#3] mootools.html Cycles:180 Average:5541.87 Median:4726.23 stddev:3221.65 (68.2%) stddev-sans-first:3214.90 21:57:44 INFO - PROCESS | 14487 | Values: 1297.1 1441.5 1501.1 1616.7 1788.0 7466.5 8424.3 8687.1 8689.9 8870.4 8676.7 8749.7 8752.6 8765.3 8765.5 2240.0 2257.5 2266.3 2268.9 2271.9 2157.7 2206.6 2207.6 2214.2 2217.8 2241.6 2244.5 2247.5 2250.4 2278.6 2230.8 2248.9 2253.2 2258.5 2261.0 2181.8 2186.9 2191.7 2191.8 2215.5 8579.7 8610.0 8687.1 8694.7 8705.0 4918.0 5054.7 5055.9 5105.0 5106.6 3231.1 3406.5 3422.9 3474.9 3478.8 958.9 1019.2 1032.3 1033.7 1058.4 11531.3 11587.8 11617.9 11705.8 11718.9 4069.1 4139.4 4273.2 4283.3 4293.0 9219.3 9302.9 9305.3 9315.9 9317.2 4886.3 4899.2 4901.5 4902.9 4906.2 4057.1 4178.1 4356.3 4540.7 4551.6 3577.1 3650.9 3745.9 3767.6 3769.9 1080.5 1117.7 1136.6 1140.2 1145.3 798.7 821.9 905.0 909.5 917.1 5311.4 5510.1 5614.8 5631.6 5814.4 843.7 890.6 935.6 944.6 958.5 3466.7 3696.0 3829.4 3847.7 3859.7 10882.0 10941.3 11042.7 11062.7 11140.3 10887.9 10936.6 10938.2 10997.5 11023.9 7646.0 7934.6 8025.7 8029.4 8170.3 5588.2 5672.0 5715.6 5721.6 5930.3 9560.8 9570.3 9978.5 10029.1 10114.0 9810.0 9936.1 10230.5 10230.8 10301.2 6568.8 6887.8 7149.5 7311.8 7313.3 8075.1 8301.4 8329.0 8344.6 8362.7 7246.1 7338.6 7440.7 7442.7 7534.1 7077.0 7103.0 7124.1 7164.2 7210.6 6241.5 6309.6 6349.8 6378.8 6400.3 4673.8 4710.2 4742.2 4748.1 4848.6 4612.1 4662.4 4683.0 4693.1 4694.7 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#4] prototype.html Cycles:180 Average:4580.97 Median:5154.36 stddev:1377.72 (26.7%) stddev-sans-first:1343.49 21:57:44 INFO - PROCESS | 14487 | Values: 294.0 297.4 306.0 306.6 312.6 5148.6 5244.3 5286.8 5322.5 5369.4 5133.8 5207.6 5217.4 5299.8 5306.9 4131.9 4151.6 4165.2 4172.4 4172.5 3913.6 4070.5 4135.2 4172.7 4190.3 4056.5 4059.0 4064.1 4064.6 4066.8 4038.7 4048.2 4052.7 4054.0 4054.5 3535.9 3537.9 3544.1 3547.3 3551.3 5080.3 5107.7 5124.6 5129.5 5160.1 4593.2 4599.8 4606.3 4607.5 4615.6 5466.7 5477.0 5479.0 5481.5 5506.3 3776.7 3848.2 3872.3 3881.3 3883.2 5701.0 5720.1 5750.5 5755.5 5756.9 3960.3 3969.6 3969.9 3985.9 4010.4 3842.2 4002.4 4010.6 4052.4 4058.2 4606.5 4613.9 4624.3 4633.6 4640.0 5551.7 5557.9 5559.8 5574.2 5590.3 1269.9 1289.6 1301.7 1315.3 1366.4 823.7 849.6 850.9 853.9 858.7 4688.9 4705.2 4712.8 4723.9 4743.8 4910.3 4910.8 4941.4 4945.6 4950.8 4655.3 4657.8 4701.7 4710.8 4728.3 2804.3 2992.9 3024.9 3026.4 3027.3 5846.5 5855.9 5872.3 5884.3 5893.1 5472.4 5707.7 5747.5 5821.5 5843.0 5806.6 5806.8 5811.3 5821.3 5821.6 5622.4 5663.2 5678.7 5697.6 5732.2 5296.6 5612.6 5638.5 5639.2 5646.4 5884.8 5887.3 5891.5 5901.3 5938.3 3841.7 3890.0 3904.6 3923.3 3930.8 5687.7 5699.0 5712.2 5734.1 5740.5 5310.7 5439.3 5466.8 5596.9 5616.7 5528.4 5572.6 5572.9 5573.5 5595.6 5326.2 5459.8 5478.2 5505.6 5578.7 5545.8 5569.7 5577.6 5581.6 5605.3 5454.7 5462.7 5515.3 5539.6 5552.3 21:57:44 INFO - PROCESS | 14487 | 21:57:44 INFO - PROCESS | 14487 | [#5] yui.html Cycles:180 Average:19546.30 Median:625.68 stddev:30067.48 (4805.5%) stddev-sans-first:30118.08 21:57:44 INFO - PROCESS | 14487 | Values: 573.3 613.7 624.1 627.2 640.0 13619.6 14227.1 14321.8 14326.2 14328.6 13064.8 13163.1 13212.7 13274.9 13285.3 632.5 769.1 789.3 792.3 793.2 661.7 782.8 804.2 804.2 812.2 848.9 850.8 852.9 853.1 853.5 836.0 837.3 837.4 840.9 843.3 618.9 622.2 627.4 627.7 628.2 12720.6 12871.2 12889.2 12893.0 12895.4 11953.1 12084.1 12629.2 12839.4 13484.3 9722.5 9894.7 10050.5 10057.3 10512.6 3430.2 3456.3 3479.1 3484.1 3599.8 75122.0 75804.0 76539.6 76750.6 78275.6 9084.5 9194.9 9371.8 9592.1 9690.3 21848.9 21896.0 21905.0 21923.3 22005.9 6657.7 6900.9 6998.1 7104.5 7524.7 3948.7 4077.0 4181.6 4221.0 4252.7 3123.0 3271.8 3274.6 3279.8 3307.9 539.1 543.5 550.8 556.2 560.1 565.5 571.2 587.2 602.7 632.9 7586.5 7894.7 8309.0 8350.3 8401.9 476.0 498.4 533.2 577.8 609.2 3795.0 3797.5 3943.2 3966.8 4069.0 110974.0 111950.4 112282.4 114855.4 117334.4 78857.2 97162.0 98395.5 99692.5 100929.0 85916.6 88609.0 89496.6 91344.0 91632.1 7243.3 7439.1 7442.4 7574.5 7843.2 49641.0 49796.0 51346.5 51495.7 53343.4 69472.0 73199.0 74490.6 75341.6 75960.2 8774.6 8985.6 9177.2 9355.8 9559.1 10442.5 10450.8 10531.5 10637.0 10673.1 9628.1 9713.3 9928.0 9962.7 10272.0 9820.4 10177.3 10296.1 10615.3 10690.5 9708.5 9997.8 10284.9 10368.1 10484.2 8010.9 8105.6 8174.5 8646.4 8796.3 7647.9 7682.3 8290.6 8724.8 8944.6 21:57:44 INFO - PROCESS | 14487 | -------- Summary: end -------- 21:57:44 INFO - PROCESS | 14487 | 21:57:45 INFO - TEST-INFO | 14487: exit 0 21:57:45 INFO - TEST-OK | dromaeo_css | took 1118208ms 21:57:45 INFO - TEST-START | kraken 21:57:45 INFO - operating with platform_type : linux_ 21:57:45 INFO - Initialising browser for kraken test... 21:57:45 INFO - TEST-INFO | started process 14798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsSXIS/profile http://localhost:54697/getInfo.html) 21:57:49 INFO - PROCESS | 14798 | __metrics Screen width/height:1600/1200 21:57:49 INFO - PROCESS | 14798 | colorDepth:24 21:57:49 INFO - PROCESS | 14798 | Browser inner width/height: 1024/697 21:57:49 INFO - PROCESS | 14798 | __metrics 21:57:49 INFO - PROCESS | 14798 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:57:49 INFO - PROCESS | 14798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:50 INFO - PROCESS | 14798 | console.error: PushService: 21:57:50 INFO - PROCESS | 14798 | stateChangeProcessEnqueue: Error transitioning state 21:57:50 INFO - PROCESS | 14798 | UnknownError 21:57:51 INFO - TEST-INFO | 14798: exit 0 21:57:51 INFO - Browser initialized. 21:57:51 INFO - Running cycle 1/1 for kraken test... 21:57:51 INFO - TEST-INFO | started process 14880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsSXIS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:03 INFO - PROCESS | 14880 | RSS: Main: 172367872 21:58:03 INFO - PROCESS | 14880 | 21:58:05 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54697/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:06 INFO - PROCESS | 14880 | RSS: Main: 229732352 21:58:06 INFO - PROCESS | 14880 | 21:58:09 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54697/tests/kraken/driver.html?testName=audio-dft) 21:58:09 INFO - PROCESS | 14880 | RSS: Main: 216510464 21:58:09 INFO - PROCESS | 14880 | 21:58:13 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54697/tests/kraken/driver.html?testName=audio-fft) 21:58:13 INFO - PROCESS | 14880 | RSS: Main: 297177088 21:58:13 INFO - PROCESS | 14880 | 21:58:15 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54697/tests/kraken/driver.html?testName=audio-oscillator) 21:58:16 INFO - PROCESS | 14880 | RSS: Main: 206393344 21:58:16 INFO - PROCESS | 14880 | 21:58:18 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:19 INFO - PROCESS | 14880 | RSS: Main: 211456000 21:58:19 INFO - PROCESS | 14880 | 21:58:22 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54697/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:22 INFO - PROCESS | 14880 | RSS: Main: 248188928 21:58:22 INFO - PROCESS | 14880 | 21:58:26 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54697/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:26 INFO - PROCESS | 14880 | RSS: Main: 246853632 21:58:26 INFO - PROCESS | 14880 | 21:58:29 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54697/tests/kraken/driver.html?testName=json-parse-financial) 21:58:29 INFO - PROCESS | 14880 | RSS: Main: 246136832 21:58:29 INFO - PROCESS | 14880 | 21:58:31 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:32 INFO - PROCESS | 14880 | RSS: Main: 208826368 21:58:32 INFO - PROCESS | 14880 | 21:58:33 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:34 INFO - PROCESS | 14880 | RSS: Main: 216313856 21:58:34 INFO - PROCESS | 14880 | 21:58:36 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:36 INFO - PROCESS | 14880 | RSS: Main: 225849344 21:58:36 INFO - PROCESS | 14880 | 21:58:39 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:40 INFO - PROCESS | 14880 | RSS: Main: 234483712 21:58:40 INFO - PROCESS | 14880 | 21:58:43 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:43 INFO - PROCESS | 14880 | RSS: Main: 231698432 21:58:43 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | Cycle 1(1): loaded http://localhost:54697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54697/tests/kraken/driver.html?testName=ai-astar) 21:58:45 INFO - PROCESS | 14880 | RSS: Main: 282890240 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | __start_tp_report 21:58:45 INFO - PROCESS | 14880 | _x_x_mozilla_page_load 21:58:45 INFO - PROCESS | 14880 | _x_x_mozilla_page_load_details 21:58:45 INFO - PROCESS | 14880 | |i|pagename|runs| 21:58:45 INFO - PROCESS | 14880 | |0;ai-astar;103;110;110;111;113;111;112;110;110;113 21:58:45 INFO - PROCESS | 14880 | |1;audio-beat-detection;165;122;122;156;123;125;124;123;173;121 21:58:45 INFO - PROCESS | 14880 | |2;audio-dft;161;164;160;163;164;162;163;164;162;160 21:58:45 INFO - PROCESS | 14880 | |3;audio-fft;76;76;77;111;76;75;75;76;102;74 21:58:45 INFO - PROCESS | 14880 | |4;audio-oscillator;83;83;119;82;82;85;101;83;82;122 21:58:45 INFO - PROCESS | 14880 | |5;imaging-gaussian-blur;118;118;118;118;117;117;118;117;118;118 21:58:45 INFO - PROCESS | 14880 | |6;imaging-darkroom;146;147;147;147;149;146;147;147;148;147 21:58:45 INFO - PROCESS | 14880 | |7;imaging-desaturate;85;85;85;84;85;85;85;85;84;85 21:58:45 INFO - PROCESS | 14880 | |8;json-parse-financial;53;52;50;50;51;53;52;52;51;52 21:58:45 INFO - PROCESS | 14880 | |9;json-stringify-tinderbox;59;59;59;59;60;59;59;59;61;60 21:58:45 INFO - PROCESS | 14880 | |10;stanford-crypto-aes;82;79;80;81;82;81;80;80;81;80 21:58:45 INFO - PROCESS | 14880 | |11;stanford-crypto-ccm;142;134;133;131;133;133;131;133;173;146 21:58:45 INFO - PROCESS | 14880 | |12;stanford-crypto-pbkdf2;166;168;169;167;172;167;168;170;166;169 21:58:45 INFO - PROCESS | 14880 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;65;65;67;66;64 21:58:45 INFO - PROCESS | 14880 | __end_tp_report 21:58:45 INFO - PROCESS | 14880 | __start_cc_report 21:58:45 INFO - PROCESS | 14880 | _x_x_mozilla_cycle_collect,1714 21:58:45 INFO - PROCESS | 14880 | __end_cc_report 21:58:45 INFO - PROCESS | 14880 | __startTimestamp1476766725720__endTimestamp 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | ------- Summary: start ------- 21:58:45 INFO - PROCESS | 14880 | Number of tests: 14 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.83 (2.5%) stddev-sans-first:1.27 21:58:45 INFO - PROCESS | 14880 | Values: 103.0 110.0 110.0 111.0 113.0 111.0 112.0 110.0 110.0 113.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:124.50 stddev:20.62 (16.6%) stddev-sans-first:18.88 21:58:45 INFO - PROCESS | 14880 | Values: 165.0 122.0 122.0 156.0 123.0 125.0 124.0 123.0 173.0 121.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.57 (1.0%) stddev-sans-first:1.59 21:58:45 INFO - PROCESS | 14880 | Values: 161.0 164.0 160.0 163.0 164.0 162.0 163.0 164.0 162.0 160.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:13.21 (17.4%) stddev-sans-first:13.85 21:58:45 INFO - PROCESS | 14880 | Values: 76.0 76.0 77.0 111.0 76.0 75.0 75.0 76.0 102.0 74.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:15.99 (19.4%) stddev-sans-first:16.61 21:58:45 INFO - PROCESS | 14880 | Values: 83.0 83.0 119.0 82.0 82.0 85.0 101.0 83.0 82.0 122.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:58:45 INFO - PROCESS | 14880 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 21:58:45 INFO - PROCESS | 14880 | Values: 146.0 147.0 147.0 147.0 149.0 146.0 147.0 147.0 148.0 147.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 21:58:45 INFO - PROCESS | 14880 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 85.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.01 21:58:45 INFO - PROCESS | 14880 | Values: 53.0 52.0 50.0 50.0 51.0 53.0 52.0 52.0 51.0 52.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 21:58:45 INFO - PROCESS | 14880 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 61.0 60.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 21:58:45 INFO - PROCESS | 14880 | Values: 82.0 79.0 80.0 81.0 82.0 81.0 80.0 80.0 81.0 80.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:133.50 stddev:12.96 (9.7%) stddev-sans-first:13.69 21:58:45 INFO - PROCESS | 14880 | Values: 142.0 134.0 133.0 131.0 133.0 133.0 131.0 133.0 173.0 146.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:1.87 (1.1%) stddev-sans-first:1.81 21:58:45 INFO - PROCESS | 14880 | Values: 166.0 168.0 169.0 167.0 172.0 167.0 168.0 170.0 166.0 169.0 21:58:45 INFO - PROCESS | 14880 | 21:58:45 INFO - PROCESS | 14880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 21:58:45 INFO - PROCESS | 14880 | Values: 67.0 67.0 67.0 66.0 66.0 65.0 65.0 67.0 66.0 64.0 21:58:45 INFO - PROCESS | 14880 | -------- Summary: end -------- 21:58:45 INFO - PROCESS | 14880 | 21:58:46 INFO - TEST-INFO | 14880: exit 0 21:58:46 INFO - TEST-OK | kraken | took 61605ms 21:58:46 INFO - SUITE-END | took 1179s 21:58:47 INFO - Completed test suite (00:19:40) 21:58:47 INFO - javascript benchmark 21:58:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2916.08143434818, 2943.3818898031413, 2971.628546431696, 2973.21209879382, 2984.089852594958, 5052.772625231864, 5195.246689230059, 5202.531772140506, 5271.525562699357, 5383.273258110149, 5180.689158650474, 5231.476852314767, 5328.120860058086, 5344.4922732340465, 5373.0, 4820.734859582722, 4844.515548445145, 4851.854444366674, 4854.17479028566, 4872.147374209517, 4866.294387313837, 4876.0, 4955.826546070888, 4961.528654777809, 5006.424261209952, 4886.828960986349, 4902.3872015998, 4948.925766113512, 4962.5533701966815, 5004.474530174334, 4617.653675974282, 4682.250839865639, 4686.625069994427, 4689.742064186468, 4780.784864681063, 4765.976170119162, 4776.0925424169645, 4789.640776941744, 4808.278758186265, 4835.540623640749, 5311.389190243094, 5319.893602127974, 5323.893522129536, 5337.759800808973, 5362.168863826113, 5376.811811586615, 5414.3232095988005, 5445.1832225166145, 5675.347335056439, 5679.687617181054, 5616.354119276254, 5621.381648018714, 5628.04323265046, 5636.774529018834, 5715.628484148517, 5275.208718692188, 5286.7092309922555, 5287.947120528823, 5288.603354748409, 5340.732963351817, 5497.175423686399, 5538.47384498472, 5555.833325000256, 5724.599278050497, 5736.856578585569, 5391.433899440581, 5486.1222204447095, 5538.47384498472, 5594.021046316879, 5598.076317407664, 5567.137093750475, 5610.579206559524, 5614.494695477427, 5615.6630602164005, 5679.119736440858, 5593.216949627055, 5603.103503439512, 5603.271574695264, 5605.047141985872, 5605.523530499871, 5364.6512976656395, 5441.265429167091, 5447.5641948644015, 5504.944950550524, 5655.604107712421, 4235.25882970479, 4258.318669012943, 4264.019275566575, 4270.7010509264055, 4271.273883439822, 3862.1696335288048, 3863.130795570974, 3865.9226815463535, 3867.535895692479, 3869.5550011748446, 5190.688558686491, 5193.246979187997, 5193.246979188072, 5195.376554813447, 5196.844094677166, 5487.4238204987905, 5487.64330318528, 5489.917651235235, 5489.945100548944, 5504.2018907258225, 5185.637005409585, 5189.42916279209, 5191.195364718475, 5191.428942816287, 5191.6884986900905, 4843.782029808667, 4938.111139994836, 4938.851834444972, 4942.975285123552, 4953.925691114636, 5864.765409383662, 5874.794382196603, 5875.471207591338, 5877.38287479817, 5884.735186916599, 5407.513323800719, 5460.34475862899, 5685.971570142123, 5693.345265294544, 5760.510356619734, 5661.207430959751, 5787.131930210502, 5788.884222315614, 5792.1311803229855, 5862.501687356623, 5520.033994051106, 5520.254765606592, 5522.641028333145, 5523.861903452285, 5532.253145825262, 5436.728163591725, 5597.63615365, 5602.3837377887585, 5607.439256074523, 5610.410906854721, 5364.329458817648, 5430.5384042356845, 5444.156155795858, 5444.50999410055, 5449.6730196188355, 5298.0, 5411.891762164813, 5418.539424148834, 5420.647657902224, 5425.321834770653, 5360.142377219626, 5367.248585198154, 5378.1663842104535, 5379.004884096455, 5381.865453363697, 5415.6479828811, 5448.128299472065, 5449.3460784706085, 5466.753996070266, 5469.206964990134, 5321.787128514816, 5347.251384806053, 5348.358197016383, 5352.197170424468, 5353.304070470814], "value": 5159.731271118368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0532518681581, 596.6062398816779, 604.7067172421372, 609.8566836793353, 623.5136593457103, 41308.17383652325, 43171.13657726844, 43360.783196083976, 43412.782936085314, 46058.0, 43731.12537749243, 44276.557234427644, 44293.33559996603, 44313.7784311078, 44324.556754432444, 7900.525968441883, 8056.798580035516, 8516.446430981981, 8625.525596092244, 8637.0, 10233.232507561963, 10488.0, 10499.370037797718, 10869.891301086967, 10884.07485363745, 10718.196135289845, 10783.352998820057, 10794.46027698616, 10800.72998175044, 10800.837987430155, 10599.258051936367, 10640.893591064107, 10674.839877401846, 10680.732981675443, 10684.465776711173, 10429.947850260776, 10516.158707303397, 10518.474076296232, 10518.631847885288, 10520.579176832918, 40050.399244011365, 40404.393934091015, 40436.59563404358, 40590.39114413286, 40635.796821015705, 2780.7497325240824, 2797.482465743844, 2864.1264414353614, 2905.694902035298, 2910.738033576988, 30592.694073059207, 31089.37821243585, 31107.0, 31326.530102048488, 31573.526397104062, 3442.913927151816, 3455.930881382358, 3487.407140786047, 3515.8945231643092, 3626.2203626220225, 300452.0, 300781.0, 301996.4900175507, 302026.0, 302565.0, 55327.72336138294, 55741.0, 55963.720181398836, 55969.44030559642, 56076.43923560712, 36243.81878090592, 37160.0, 37282.44076338857, 37304.44043339298, 60114.39885601088, 16334.509964701077, 16453.0, 16479.83520164783, 16495.257713402927, 16498.505044848673, 11444.942775286238, 11745.0, 12120.27278363301, 12202.38988050594, 12454.25274483534, 18625.53436164107, 18634.81365186358, 18647.44057678272, 18742.437726868215, 18754.718679219823, 6907.0883282489785, 7019.227884932653, 7174.426045916419, 7176.174739904874, 7211.747588834365, 895.6283142495921, 989.7970915962211, 1040.2250323509033, 1061.2412125330425, 1086.071408945356, 29657.85171074131, 31139.84430077835, 31242.0, 31538.0, 31742.841285793424, 1043.780806030742, 1096.6709987004026, 1108.7172770943357, 1131.9868717497793, 1139.3790384240608, 15847.920760396124, 16717.414890478776, 16773.0, 16786.328546858233, 17088.487345379657, 515028.0, 522950.0, 525550.0, 802917.0, 806213.0, 57435.425645743846, 57790.7110464445, 57864.42135578675, 58072.70963645239, 58154.127688084714, 1182.760371554024, 1242.043626407679, 1291.6770807298176, 1304.5564508067303, 1332.0875200487696, 27500.449990999667, 32393.514097288087, 32516.18709532186, 32565.837170813993, 32832.67167328296, 49481.50518494769, 50152.0, 50161.49838501714, 50204.0, 50221.74889125531, 405329.0, 410216.46752986097, 410820.0, 410982.0, 411429.45702331, 26705.19884403471, 27135.5075470851, 27343.726562734915, 28413.857930710215, 28417.43165136727, 45804.77097614491, 46731.29903051525, 46732.53267467282, 46973.295400568335, 47100.7644961773, 38399.80800095982, 38947.0, 39023.0, 39332.606673932896, 40026.59973400229, 38950.220995580494, 39117.804410978904, 39120.21759564849, 39447.80276098716, 41045.0, 39438.0, 40044.199116016935, 41549.584504155784, 42528.14943701047, 45297.320540191264, 37398.626013739515, 41817.16365672609, 42070.36894446647, 42354.0, 42723.3591496134, 30979.225519362197, 32885.50671739974, 33267.0, 33501.0, 33537.66462335443], "value": 19889.830833141365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.15646089841175, 357.9176789338452, 365.384327408317, 370.64233015140394, 385.7531180044772, 13936.721265574695, 17666.470005899828, 18377.816221837795, 18809.811901880978, 19894.0, 17300.740488892676, 17321.480355589352, 17584.82415175848, 17818.554536136602, 18387.356442524513, 4851.781669824857, 5153.6392452528335, 5158.097332966735, 5162.432132465445, 5166.793328266865, 3785.299719551878, 3823.8661646842365, 5088.236764485338, 5165.199394093903, 5165.7158856262895, 4211.220924129046, 4314.3097104463295, 6393.424591786738, 6403.0, 6417.422431981121, 6190.350013248589, 6338.0, 6427.068075129104, 6431.260405053432, 6442.387973142544, 5613.4386561343945, 5618.0, 5624.91562626561, 5625.578081643852, 5625.634333768333, 21401.67897481539, 21456.14175432981, 21486.57026859454, 21853.0, 22027.0, 2051.2307884543297, 2103.5582527669208, 2177.6760843613274, 2192.4299682082615, 2888.7544558712534, 8780.912190878073, 8848.292136629054, 8953.955230223872, 9191.35660503765, 9244.815103697889, 1742.3466200174935, 1754.6227561074302, 1833.8532917366579, 1844.62185252023, 1863.506170864722, 70069.64965175193, 74766.0, 75142.0, 76159.99999999945, 77427.0, 9956.103950644478, 10093.091621754078, 10174.389536627827, 10216.642417515352, 10251.12865406434, 13962.58112256634, 13963.511277105456, 13967.720645587031, 13977.3710183042, 14003.0, 7486.43851711113, 7656.525584207318, 7686.0, 7705.267999540035, 7897.605119744105, 7402.1117465904435, 7459.254074592497, 7632.503887247422, 7676.692932282646, 7718.035245594301, 4130.690198235145, 4266.978665106717, 4308.332208507686, 4412.779361031936, 4423.800928958204, 1693.2126561149125, 1740.904250266222, 1767.5669460982142, 1776.5736223306315, 1787.052861983125, 912.8767616371838, 948.8766460360109, 973.3040875773855, 1003.1022235099545, 1009.8737657792776, 17249.706272029398, 18713.0, 18823.90588047051, 19097.140628671743, 19233.326833560757, 916.706653870755, 939.5912777941618, 972.8783902012249, 994.7761753605381, 1004.8743907011624, 9882.357646752938, 10570.418626975435, 10604.522796474022, 10674.839877401846, 10692.732681682864, 439729.0, 457499.0, 461381.0, 482515.0, 483698.0, 79845.60077199577, 80658.59670701726, 81516.18483815086, 81558.0, 82172.17827821765, 965.7199412170391, 978.7748817771952, 980.7302991677345, 984.9753756156153, 994.2990191914682, 15708.60728481797, 15827.208639568205, 15934.9203253983, 15991.280392382603, 16960.660786784443, 38826.2234755309, 39090.80454597709, 40154.0, 40640.73272306365, 40897.59102408938, 48644.270335945694, 48786.0, 52134.47865521296, 52332.73833630807, 53662.46337536575, 7588.962055189689, 7630.0, 7657.923420765721, 7756.224377562198, 7850.6074696266105, 9339.859902101338, 12302.200356976768, 12499.500019999461, 12606.810897836356, 12692.619221423372, 10632.734181645521, 10712.946435267773, 10960.9722201393, 11177.832332515181, 11428.428578570873, 10486.161107111566, 10553.525091370753, 10575.841362379724, 10667.89332106669, 10818.026377625736, 10940.507677154706, 11118.277311974696, 11253.606123785628, 11313.71715707114, 11748.70628234301, 7921.207879212263, 7934.127246002819, 7994.801429606905, 8102.0, 8114.0, 8011.118776934649, 10862.511186996762, 10974.725631859268, 11013.779724405627, 11193.705290415282], "value": 8604.800051882903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.0985165310112, 1441.5170917742555, 1501.1443477217983, 1616.7332390155625, 1787.9821201787986, 7466.51467654602, 8424.283935865451, 8687.08785577514, 8689.91310086899, 8870.423422477534, 8676.652933882653, 8749.69376071836, 8752.606132724026, 8765.254953328958, 8765.47407155571, 2240.0367841828006, 2257.480779420734, 2266.286119872243, 2268.875211863347, 2271.909123635061, 2157.7194964654573, 2206.58074965756, 2207.6467765157577, 2214.1586197245024, 2217.7782221777857, 2241.5628952354296, 2244.461329280969, 2247.4606094537357, 2250.3923940536047, 2278.646809744492, 2230.8438409311357, 2248.9325320240337, 2253.188852013274, 2258.4692597239555, 2261.0, 2181.7709140540333, 2186.8797216153107, 2191.6712493126, 2191.835612329082, 2215.4682876109778, 8579.742607721715, 8610.0, 8687.131286871325, 8694.652213911437, 8705.0, 4917.950820491821, 5054.721990290533, 5055.9241611375855, 5104.974475127638, 5106.64253502255, 3231.0952933178746, 3406.5230867678547, 3422.931541369159, 3474.9305013899834, 3478.826058697055, 958.8849338079406, 1019.2253887045824, 1032.3135115148418, 1033.7260625934134, 1058.4072919165292, 11531.308121512737, 11587.826182607268, 11617.94191029048, 11705.765884682258, 11718.945294923413, 4069.084455997436, 4139.441175441337, 4273.18809426208, 4283.2932566126865, 4293.0, 9219.308551858638, 9302.906970930204, 9305.25557955362, 9315.906840931504, 9317.16145546904, 4886.340344053508, 4899.167141585939, 4901.485344038896, 4902.90194196114, 4906.190478571068, 4057.087155390014, 4178.143480586473, 4356.281213599784, 4540.704854184468, 4551.635869130461, 3577.069961809896, 3650.926981460356, 3745.850165993384, 3767.56672982605, 3769.8869033929027, 1080.5245691895698, 1117.742919128605, 1136.5737848306885, 1140.2303445174473, 1145.2841973766397, 798.7084714079319, 821.9383546234056, 904.9638014479478, 909.4634165842185, 917.0691747875911, 5311.442298558596, 5510.118381059011, 5614.775408983676, 5631.633943793722, 5814.389489103583, 843.6751850537587, 890.6481939633809, 935.555611084743, 944.593824655391, 958.4680502321139, 3466.665333846487, 3695.963040369562, 3829.4064420014943, 3847.730658853853, 3859.729818912649, 10882.0, 10941.28881622692, 11042.723931901766, 11062.668119956414, 11140.275882067639, 10887.945560272148, 10936.56253749841, 10938.234323597271, 10997.505112269808, 11023.889761102446, 7646.0, 7934.603269836485, 8025.719099831478, 8029.397795165386, 8170.264676179172, 5588.2455868458865, 5672.0, 5715.571332150189, 5721.57088218377, 5930.347661757117, 9560.76098097553, 9570.282228833004, 9978.451185184884, 10029.147522460673, 10114.039166279192, 9810.0, 9936.105750482491, 10230.539625717009, 10230.795384092426, 10301.227407944285, 6568.770093046721, 6887.793366199022, 7149.53528020677, 7311.780646580399, 7313.341799237881, 8075.071366792894, 8301.377396695152, 8328.958355208186, 8344.58277086131, 8362.707305244287, 7246.094238220223, 7338.596377199306, 7440.73957411488, 7442.665080071518, 7534.133574638768, 7076.964615176891, 7102.964485177541, 7124.109486314211, 7164.176119746296, 7210.567365958059, 6241.469475094668, 6309.621422714468, 6349.841253968688, 6378.808635740936, 6400.295967443671, 4673.789679464364, 4710.222813235915, 4742.241241401359, 4748.0978614063215, 4848.612111031039, 4612.100640375094, 4662.417197850269, 4683.0, 4693.131770622445, 4694.718316900997], "value": 4403.387932831966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.9970600293998, 297.3962855403531, 305.97093276138776, 306.5616168878503, 312.596750192252, 5148.588112950964, 5244.292020577221, 5286.762095705692, 5322.467753224681, 5369.436209198032, 5133.845984620468, 5207.609429292808, 5217.426083130853, 5299.788008479656, 5306.91208302298, 4131.8553850615235, 4151.564085770996, 4165.229777344632, 4172.436721042651, 4172.52016018158, 3913.6086391360923, 4070.450489183952, 4135.214309281242, 4172.666186705056, 4190.28765109932, 4056.5132184137947, 4058.9594104059024, 4064.146529228851, 4064.634182923536, 4066.8169932352966, 4038.737482063686, 4048.2308361411237, 4052.7365721228175, 4054.0270335119358, 4054.493188351456, 3535.9116022099397, 3537.858485660596, 3544.0962554548682, 3547.255076433952, 3551.254236610315, 5080.288759573663, 5107.744612769384, 5124.564412024945, 5129.512696293846, 5160.122779127557, 4593.219152744042, 4599.816007359702, 4606.26299792035, 4607.516210797851, 4615.584597386218, 5466.699331536764, 5476.972615136939, 5478.972605136949, 5481.451854814526, 5506.339239291271, 3776.66010059096, 3848.1726428817938, 3872.341701910682, 3881.3013657541633, 3883.203943191639, 5700.971495142539, 5720.141978703186, 5750.482456578928, 5755.510781583571, 5756.884862302731, 3960.2871483133313, 3969.583193764613, 3969.861054863066, 3985.880423587297, 4010.438538604598, 3842.2315536892734, 4002.399640054015, 4010.5588385277597, 4052.4326594276827, 4058.1680755445063, 4606.539346065367, 4613.861584152481, 4624.26011838111, 4633.606143477842, 4639.976800115978, 5551.72241387929, 5557.944420555743, 5559.77760889568, 5574.247476590608, 5590.273264475592, 1269.8984081273477, 1289.5744404346542, 1301.7266374061364, 1315.283170671986, 1366.3646404421793, 823.6952327638812, 849.6363336844399, 850.9319254459629, 853.9316854651613, 858.6994551906907, 4688.929666055012, 4705.223638099676, 4712.818847278074, 4723.913499895043, 4743.810247590127, 4910.312556242129, 4910.754462276872, 4941.407031156285, 4945.604351651859, 4950.777215025332, 4655.348251244828, 4657.836975705834, 4701.670883038155, 4710.764461776897, 4728.290756386569, 2804.2568719288997, 2992.940141197164, 3024.941270555288, 3026.379592183597, 3027.3188532579993, 5846.473817356458, 5855.853603659943, 5872.324682661549, 5884.264466941632, 5893.086571581412, 5472.425395333512, 5707.686077265707, 5747.511461525817, 5821.505172060338, 5843.0, 5806.564507661942, 5806.751548417111, 5811.273590801235, 5821.27234095738, 5821.563382746395, 5622.409646987007, 5663.187779910554, 5678.659280443187, 5697.601167918206, 5732.226149469935, 5296.576273898002, 5612.5509959202345, 5638.520725738194, 5639.210510528611, 5646.3788983212635, 5884.7940322088525, 5887.292685121267, 5891.525559265205, 5901.29184497863, 5938.257717785277, 3841.6926645867707, 3889.969158173143, 3904.613862078921, 3923.2545816294814, 3930.80345982694, 5687.658740475585, 5699.0, 5712.171735098471, 5734.050422856249, 5740.512056475246, 5310.707911064928, 5439.292891924025, 5466.835994920159, 5596.916046259391, 5616.69108199053, 5528.391876893458, 5572.582056345709, 5572.91640625399, 5573.498385145356, 5595.552355811444, 5326.174442961347, 5459.808906688247, 5478.233047373291, 5505.559555235492, 5578.693171875586, 5545.805896793754, 5569.721513924206, 5577.553795696415, 5581.5813813963305, 5605.271314729059, 5454.727263636882, 5462.726863656721, 5515.338159420895, 5539.556835453234, 5552.278793574005], "value": 4127.279839938697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3234782956112, 613.7268915332677, 624.1490006658914, 627.2191122053044, 639.9776007839727, 13619.591412257623, 14227.146371217708, 14321.78517322241, 14326.212058336787, 14328.570142895704, 13064.804027939588, 13163.07858449909, 13212.735745285088, 13274.867251327483, 13285.269310187936, 632.4529282170912, 769.0924708843562, 789.2738680414033, 792.2671528835832, 793.2067932067932, 661.6592454885738, 782.8395178988322, 804.1556365815899, 804.2118723650826, 812.1675282835082, 848.8641817309232, 850.8128211793427, 852.8635418333068, 853.0957185383483, 853.4537895746727, 835.9665613375457, 837.3426859914938, 837.417994493827, 840.9453385529952, 843.304273973974, 618.9257289125288, 622.2346513788066, 627.4008322052429, 627.6861569215392, 628.2398298059354, 12720.61838144848, 12871.22772633645, 12889.162204456774, 12893.033022523254, 12895.355232238351, 11953.103517236243, 12084.104892180883, 12629.2422454653, 12839.358032098358, 13484.325783710776, 9722.513874306256, 9894.703158905244, 10050.547725352377, 10057.346272492265, 10512.632057877938, 3430.2281986553076, 3456.343294773985, 3479.0780443182575, 3484.0767196692896, 3599.784012959231, 75121.99008145947, 75804.0, 76539.61730191369, 76750.6162469184, 78275.6086219571, 9084.454932703928, 9194.90805091954, 9371.812563748686, 9592.136707696342, 9690.321677482509, 21848.89075554612, 21896.0, 21905.0, 21923.342299731034, 22005.889970550044, 6657.667116644246, 6900.896486552706, 6998.125234345707, 7104.502684812013, 7524.736634217776, 3948.6643635290748, 4077.041895154636, 4181.560936101726, 4221.008063105168, 4252.681048921343, 3122.953155702666, 3271.8036917785007, 3274.6070471543567, 3279.8032118072992, 3307.9007629770663, 539.1023945131391, 543.4918351341508, 550.754914063246, 556.1935193968761, 560.1289994059196, 565.5164834066895, 571.180356188862, 587.2453896742666, 602.7317843559574, 632.9366664004425, 7586.544807311579, 7894.723684671124, 8309.0, 8350.33197344211, 8401.873971890427, 475.97858096385744, 498.41685228282995, 533.1789044870856, 577.794882816594, 609.1928195141455, 3794.962050379461, 3797.487339209227, 3943.211357728466, 3966.7619942803526, 4068.959310406917, 110974.0, 111950.44024779987, 112282.43858780654, 114855.42572287252, 117334.41332793281, 78857.21142788499, 97162.0, 98395.50802245943, 99692.5015374933, 100929.0, 85916.57041714876, 88609.0, 89496.5525172383, 91344.0, 91632.08367916502, 7243.311885370881, 7439.107307123179, 7442.441816863865, 7574.545527268381, 7843.176466471166, 49641.0, 49796.0, 51346.48653513417, 51495.74252128715, 53343.39667909503, 69472.0, 73199.0, 74490.62754686191, 75341.6232918832, 75960.24039759532, 8774.556780067, 8985.595648195978, 9177.174054335143, 9355.766105847137, 9559.091886270793, 10442.530086146293, 10450.843237351293, 10531.526081326205, 10637.042666160083, 10673.146148307962, 9628.085331893459, 9713.271504637321, 9927.950360248153, 9962.712304939208, 10272.024157705006, 9820.361676491006, 10177.338472999232, 10296.124829389586, 10615.256932014685, 10690.518926648476, 9708.5145742714, 9997.750056248651, 10284.911777449139, 10368.066873981377, 10484.217682993756, 8010.879836802569, 8105.554194519123, 8174.468659537111, 8646.394752367274, 8796.340274479311, 7647.885281720667, 7682.270184332479, 8290.626921788655, 8724.825503489768, 8944.552772361487], "value": 6569.481729086324, "unit": "score"}], "name": "dromaeo_css", "value": 6873.396128449026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 111.0, 113.0, 111.0, 112.0, 110.0, 110.0, 113.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 122.0, 122.0, 156.0, 123.0, 125.0, 124.0, 123.0, 173.0, 121.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 163.0, 164.0, 162.0, 163.0, 164.0, 162.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 111.0, 76.0, 75.0, 75.0, 76.0, 102.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 119.0, 82.0, 82.0, 85.0, 101.0, 83.0, 82.0, 122.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 50.0, 50.0, 51.0, 53.0, 52.0, 52.0, 51.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 81.0, 82.0, 81.0, 80.0, 80.0, 81.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 133.0, 131.0, 133.0, 133.0, 131.0, 133.0, 173.0, 146.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 169.0, 167.0, 172.0, 167.0, 168.0, 170.0, 166.0, 169.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1496.3000000000002, "alertThreshold": 2.0}]} 21:58:47 INFO - Return code: 0 21:58:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:47 INFO - # TBPL SUCCESS # 21:58:47 INFO - Running post-action listener: _resource_record_post_action 21:58:47 INFO - [mozharness: 2016-10-18 04:58:47.515783Z] Finished run-tests step (success) 21:58:47 INFO - Running post-run listener: _resource_record_post_run 21:58:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 392007680; Read time: 0; Write time: 302780 21:58:47 INFO - TinderboxPrint: CPU usage
13.1% 21:58:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:58:47 INFO - TinderboxPrint: I/O write bytes / time
392,007,680 / 302,780 21:58:47 INFO - TinderboxPrint: CPU idle
8,302.4 (86.9%) 21:58:47 INFO - TinderboxPrint: CPU user
1,198.1 (12.5%) 21:58:47 INFO - TinderboxPrint: Swap in / out
0 / 0 21:58:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103682048; Read time: 0; Write time: 99276 21:58:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287862784; Read time: 0; Write time: 203504 21:58:48 INFO - Running post-run listener: _upload_blobber_files 21:58:48 INFO - Blob upload gear active. 21:58:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:48 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 21:58:48 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:58:48 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:58:48 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:51 INFO - (blobuploader) - INFO - Done attempting. 21:58:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:58:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:52 INFO - (blobuploader) - INFO - Done attempting. 21:58:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:58:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:58:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:53 INFO - (blobuploader) - INFO - Done attempting. 21:58:53 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:53 INFO - Return code: 0 21:58:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf4e14ae6f8fabb4eb221731592aacb067b76fbc130dd33c1b01ec0ed265fc201a040eee0b401c6edd7c05f4ad707706bbb1f2c413245680a4fcc56c03404e28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd5074f00c8c7c81efdb1680029b4343b155451bf49bbcd8db81ad1a589df0cb563da459b2e991dc983369752a02ffb6a4ec0b3957085b7b27f12cec2ae7e9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afbe04a037d328a0ec8d3f6f53c0b9380d7ae077a71226cc809c1933918711f4ff6511b4b1756e31774b613f4a7b729962f7bf70a4e4ec2a33545176b57b77a6"} 21:58:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:53 INFO - Contents: 21:58:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf4e14ae6f8fabb4eb221731592aacb067b76fbc130dd33c1b01ec0ed265fc201a040eee0b401c6edd7c05f4ad707706bbb1f2c413245680a4fcc56c03404e28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd5074f00c8c7c81efdb1680029b4343b155451bf49bbcd8db81ad1a589df0cb563da459b2e991dc983369752a02ffb6a4ec0b3957085b7b27f12cec2ae7e9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afbe04a037d328a0ec8d3f6f53c0b9380d7ae077a71226cc809c1933918711f4ff6511b4b1756e31774b613f4a7b729962f7bf70a4e4ec2a33545176b57b77a6"} 21:58:53 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:53 INFO - Copying logs to upload dir... 21:58:53 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.731802 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-17 21:58:53.041122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:58:53.045117) ========= 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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf4e14ae6f8fabb4eb221731592aacb067b76fbc130dd33c1b01ec0ed265fc201a040eee0b401c6edd7c05f4ad707706bbb1f2c413245680a4fcc56c03404e28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd5074f00c8c7c81efdb1680029b4343b155451bf49bbcd8db81ad1a589df0cb563da459b2e991dc983369752a02ffb6a4ec0b3957085b7b27f12cec2ae7e9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afbe04a037d328a0ec8d3f6f53c0b9380d7ae077a71226cc809c1933918711f4ff6511b4b1756e31774b613f4a7b729962f7bf70a4e4ec2a33545176b57b77a6"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476754207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf4e14ae6f8fabb4eb221731592aacb067b76fbc130dd33c1b01ec0ed265fc201a040eee0b401c6edd7c05f4ad707706bbb1f2c413245680a4fcc56c03404e28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cd5074f00c8c7c81efdb1680029b4343b155451bf49bbcd8db81ad1a589df0cb563da459b2e991dc983369752a02ffb6a4ec0b3957085b7b27f12cec2ae7e9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afbe04a037d328a0ec8d3f6f53c0b9380d7ae077a71226cc809c1933918711f4ff6511b4b1756e31774b613f4a7b729962f7bf70a4e4ec2a33545176b57b77a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:58:53.071107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:58:53.071425) ========= 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-1476765494.175293-1238792284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:58:53.154625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 21:58:53.154942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 21:58:53.155241) ========= ========= Total master_lag: 0.16 =========