builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1461899320.19 results: success (0) buildid: 20160428173013 builduid: f076db7a89d242db9af48be821cdc182 revision: 98aa054d9e2757e43158b0c962be9cbab784e9e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.187598) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.188424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.188923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.208307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.208916) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 20:08:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.0M=0s 2016-04-28 20:08:40 (41.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.389641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.390014) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017685 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.439575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:40.439994) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98aa054d9e2757e43158b0c962be9cbab784e9e2 --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 98aa054d9e2757e43158b0c962be9cbab784e9e2 --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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 20:08:40,979 truncating revision to first 12 chars 2016-04-28 20:08:40,979 Setting DEBUG logging. 2016-04-28 20:08:40,979 attempt 1/10 2016-04-28 20:08:40,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98aa054d9e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 20:08:41,340 unpacking tar archive at: fx-team-98aa054d9e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:41.109713) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:41.110077) ========= script_repo_revision: 98aa054d9e2757e43158b0c962be9cbab784e9e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:41.110479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:41.110763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 20:08:41.121187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 20:08:41.121617) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:08:41 INFO - MultiFileLogger online at 20160428 20:08:41 in /builds/slave/test 20:08:41 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 20:08:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:41 INFO - {'append_to_log': False, 20:08:41 INFO - 'base_work_dir': '/builds/slave/test', 20:08:41 INFO - 'blob_upload_branch': 'Fx-Team', 20:08:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:41 INFO - 'branch': 'Fx-Team', 20:08:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:41 INFO - 'config_files': ('talos/linux_config.py',), 20:08:41 INFO - 'default_actions': ('clobber', 20:08:41 INFO - 'read-buildbot-config', 20:08:41 INFO - 'download-and-extract', 20:08:41 INFO - 'populate-webroot', 20:08:41 INFO - 'create-virtualenv', 20:08:41 INFO - 'install', 20:08:41 INFO - 'run-tests'), 20:08:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:41 INFO - 'download_minidump_stackwalk': True, 20:08:41 INFO - 'download_symbols': 'ondemand', 20:08:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:41 INFO - 'installer_path': 'installer.exe', 20:08:41 INFO - 'log_level': 'info', 20:08:41 INFO - 'log_name': 'talos', 20:08:41 INFO - 'log_to_console': True, 20:08:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:08:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:08:41 INFO - 'opt_config_files': (), 20:08:41 INFO - 'pip_index': False, 20:08:41 INFO - 'sps_profile': False, 20:08:41 INFO - 'sps_profile_interval': 0, 20:08:41 INFO - 'suite': 'dromaeojs', 20:08:41 INFO - 'system_bits': '32', 20:08:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:41 INFO - 'title': 'talos-linux64-ix-007', 20:08:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:41 INFO - 'use_talos_json': True, 20:08:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:41 INFO - 'work_dir': 'build'} 20:08:41 INFO - ##### 20:08:41 INFO - ##### Running clobber step. 20:08:41 INFO - ##### 20:08:41 INFO - Running pre-action listener: _resource_record_pre_action 20:08:41 INFO - Running main action method: clobber 20:08:41 INFO - rmtree: /builds/slave/test/build 20:08:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:42 INFO - Running post-action listener: _resource_record_post_action 20:08:42 INFO - ##### 20:08:42 INFO - ##### Running read-buildbot-config step. 20:08:42 INFO - ##### 20:08:42 INFO - Running pre-action listener: _resource_record_pre_action 20:08:42 INFO - Running main action method: read_buildbot_config 20:08:42 INFO - Using buildbot properties: 20:08:42 INFO - { 20:08:42 INFO - "project": "", 20:08:42 INFO - "product": "firefox", 20:08:42 INFO - "script_repo_revision": "production", 20:08:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:08:42 INFO - "repository": "", 20:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:08:42 INFO - "buildid": "20160428173013", 20:08:42 INFO - "pgo_build": "True", 20:08:42 INFO - "basedir": "/builds/slave/test", 20:08:42 INFO - "buildnumber": 1120, 20:08:42 INFO - "slavename": "talos-linux64-ix-007", 20:08:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:08:42 INFO - "platform": "ubuntu64_hw", 20:08:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:08:42 INFO - "branch": "fx-team", 20:08:42 INFO - "repo_path": "integration/fx-team", 20:08:42 INFO - "revision": "98aa054d9e2757e43158b0c962be9cbab784e9e2", 20:08:42 INFO - "stage_platform": "linux64-pgo", 20:08:42 INFO - "builduid": "f076db7a89d242db9af48be821cdc182", 20:08:42 INFO - "slavebuilddir": "test" 20:08:42 INFO - } 20:08:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:08:42 INFO - Running post-action listener: _resource_record_post_action 20:08:42 INFO - ##### 20:08:42 INFO - ##### Running download-and-extract step. 20:08:42 INFO - ##### 20:08:42 INFO - Running pre-action listener: _resource_record_pre_action 20:08:42 INFO - Running main action method: download_and_extract 20:08:42 INFO - mkdir: /builds/slave/test/build/tests 20:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:42 INFO - https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:08:43 INFO - Downloaded 1361 bytes. 20:08:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:08:43 INFO - Using the following test package requirements: 20:08:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:08:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:08:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'jsshell-linux-x86_64.zip'], 20:08:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:08:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:08:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:08:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:08:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:08:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:08:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:43 INFO - https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:44 INFO - Downloaded 23873634 bytes. 20:08:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:08:46 INFO - Return code: 0 20:08:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:46 INFO - https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:49 INFO - Downloaded 23873634 bytes. 20:08:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:08:50 INFO - Return code: 0 20:08:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:50 INFO - https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:08:51 INFO - Downloaded 10840145 bytes. 20:08:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:08:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:08:52 INFO - Return code: 0 20:08:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:52 INFO - https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:08:53 INFO - Downloaded 58396402 bytes. 20:08:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:08:53 INFO - mkdir: /builds/slave/test/properties 20:08:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:53 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:53 INFO - Contents: 20:08:53 INFO - build_url:https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:08:54 INFO - Running post-action listener: _resource_record_post_action 20:08:54 INFO - Running post-action listener: set_extra_try_arguments 20:08:54 INFO - ##### 20:08:54 INFO - ##### Running populate-webroot step. 20:08:54 INFO - ##### 20:08:54 INFO - Running pre-action listener: _resource_record_pre_action 20:08:54 INFO - Running main action method: populate_webroot 20:08:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:54 INFO - '--tppagecycles', 20:08:54 INFO - '7'], 20:08:54 INFO - 'tests': ['tsvgm']}}, 20:08:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['damp', 'tps']}, 20:08:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'tests': ['damp', 'tps']}, 20:08:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['dromaeo_dom']}, 20:08:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['a11yr', 20:08:54 INFO - 'ts_paint', 20:08:54 INFO - 'tpaint', 20:08:54 INFO - 'sessionrestore', 20:08:54 INFO - 'sessionrestore_no_auto_restore', 20:08:54 INFO - 'tabpaint']}, 20:08:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['tsvgx', 20:08:54 INFO - 'tsvgr_opacity', 20:08:54 INFO - 'tart', 20:08:54 INFO - 'tscrollx', 20:08:54 INFO - 'cart']}, 20:08:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:54 INFO - 'tsvgr_opacity', 20:08:54 INFO - 'tart', 20:08:54 INFO - 'tscrollx', 20:08:54 INFO - 'cart']}, 20:08:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'talos_options': ['--disable-e10s'], 20:08:54 INFO - 'tests': ['tp5o']}, 20:08:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'tests': ['tp5o']}, 20:08:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'talos_options': ['--disable-e10s', 20:08:54 INFO - '--xperf_path', 20:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:54 INFO - 'tests': ['tp5n']}, 20:08:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:54 INFO - 'talos_options': ['--xperf_path', 20:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:54 INFO - 'tests': ['tp5n']}}, 20:08:54 INFO - 'talos.zip': {'path': '', 20:08:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:54 INFO - Running post-action listener: _resource_record_post_action 20:08:54 INFO - ##### 20:08:54 INFO - ##### Running create-virtualenv step. 20:08:54 INFO - ##### 20:08:54 INFO - Running pre-action listener: _resource_record_pre_action 20:08:54 INFO - Running main action method: create_virtualenv 20:08:54 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:54 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 20:08:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:54 INFO - Using real prefix '/usr' 20:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:55 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:57 INFO - Installing pip.................done. 20:08:57 INFO - Return code: 0 20:08:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:57 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:08:57 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 20:08:57 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 20:08:57 INFO - Using env: {'DISPLAY': ':0', 20:08:57 INFO - 'HOME': '/home/cltbld', 20:08:57 INFO - 'LANG': 'en_US.UTF-8', 20:08:57 INFO - 'LANGUAGE': 'en_US:en', 20:08:57 INFO - 'LOGNAME': 'cltbld', 20:08:57 INFO - 'MAIL': '/var/mail/cltbld', 20:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:57 INFO - 'MOZ_NO_REMOTE': '1', 20:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:57 INFO - 'NO_EM_RESTART': '1', 20:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:57 INFO - 'PWD': '/builds/slave/test', 20:08:57 INFO - 'SHELL': '/bin/bash', 20:08:57 INFO - 'SHLVL': '1', 20:08:57 INFO - 'TERM': 'linux', 20:08:57 INFO - 'TMOUT': '86400', 20:08:57 INFO - 'USER': 'cltbld', 20:08:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:57 INFO - '_': '/tools/buildbot/bin/python'} 20:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:57 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 20:08:57 INFO - Cleaning up... 20:08:57 INFO - Return code: 0 20:08:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:08:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:57 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:08:57 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>=0.7.1'] in /builds/slave/test/build 20:08:57 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>=0.7.1 20:08:57 INFO - Using env: {'DISPLAY': ':0', 20:08:57 INFO - 'HOME': '/home/cltbld', 20:08:57 INFO - 'LANG': 'en_US.UTF-8', 20:08:57 INFO - 'LANGUAGE': 'en_US:en', 20:08:57 INFO - 'LOGNAME': 'cltbld', 20:08:57 INFO - 'MAIL': '/var/mail/cltbld', 20:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:57 INFO - 'MOZ_NO_REMOTE': '1', 20:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:57 INFO - 'NO_EM_RESTART': '1', 20:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:57 INFO - 'PWD': '/builds/slave/test', 20:08:57 INFO - 'SHELL': '/bin/bash', 20:08:57 INFO - 'SHLVL': '1', 20:08:57 INFO - 'TERM': 'linux', 20:08:57 INFO - 'TMOUT': '86400', 20:08:57 INFO - 'USER': 'cltbld', 20:08:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:57 INFO - '_': '/tools/buildbot/bin/python'} 20:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:57 INFO - Downloading/unpacking psutil>=0.7.1 20:08:57 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 20:08:57 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 20:08:57 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 20:08:57 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 20:08:57 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 20:08:57 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 20:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:59 INFO - Installing collected packages: psutil 20:08:59 INFO - Running setup.py install for psutil 20:08:59 INFO - building 'psutil._psutil_linux' extension 20:08:59 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 20:08:59 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 20:08:59 INFO - building 'psutil._psutil_posix' extension 20:08:59 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 20:08:59 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 20:09:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:00 INFO - Successfully installed psutil 20:09:00 INFO - Cleaning up... 20:09:00 INFO - Return code: 0 20:09:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:09:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:00 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:00 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.0.0'] in /builds/slave/test/build 20:09:00 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.0.0 20:09:00 INFO - Using env: {'DISPLAY': ':0', 20:09:00 INFO - 'HOME': '/home/cltbld', 20:09:00 INFO - 'LANG': 'en_US.UTF-8', 20:09:00 INFO - 'LANGUAGE': 'en_US:en', 20:09:00 INFO - 'LOGNAME': 'cltbld', 20:09:00 INFO - 'MAIL': '/var/mail/cltbld', 20:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:00 INFO - 'MOZ_NO_REMOTE': '1', 20:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:00 INFO - 'NO_EM_RESTART': '1', 20:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:00 INFO - 'PWD': '/builds/slave/test', 20:09:00 INFO - 'SHELL': '/bin/bash', 20:09:00 INFO - 'SHLVL': '1', 20:09:00 INFO - 'TERM': 'linux', 20:09:00 INFO - 'TMOUT': '86400', 20:09:00 INFO - 'USER': 'cltbld', 20:09:00 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:00 INFO - '_': '/tools/buildbot/bin/python'} 20:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:00 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 20:09:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:09:02 INFO - Installing collected packages: mozsystemmonitor 20:09:02 INFO - Running setup.py install for mozsystemmonitor 20:09:02 INFO - Successfully installed mozsystemmonitor 20:09:02 INFO - Cleaning up... 20:09:02 INFO - Return code: 0 20:09:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:02 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 20:09:02 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 20:09:02 INFO - Using env: {'DISPLAY': ':0', 20:09:02 INFO - 'HOME': '/home/cltbld', 20:09:02 INFO - 'LANG': 'en_US.UTF-8', 20:09:02 INFO - 'LANGUAGE': 'en_US:en', 20:09:02 INFO - 'LOGNAME': 'cltbld', 20:09:02 INFO - 'MAIL': '/var/mail/cltbld', 20:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:02 INFO - 'MOZ_NO_REMOTE': '1', 20:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:02 INFO - 'NO_EM_RESTART': '1', 20:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:02 INFO - 'PWD': '/builds/slave/test', 20:09:02 INFO - 'SHELL': '/bin/bash', 20:09:02 INFO - 'SHLVL': '1', 20:09:02 INFO - 'TERM': 'linux', 20:09:02 INFO - 'TMOUT': '86400', 20:09:02 INFO - 'USER': 'cltbld', 20:09:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:02 INFO - '_': '/tools/buildbot/bin/python'} 20:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:02 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 20:09:02 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 20:09:02 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 20:09:02 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 20:09:02 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 20:09:02 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 20:09:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:04 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 20:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:05 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 20:09:05 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 20:09:05 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 20:09:05 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 20:09:05 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 20:09:05 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 20:09:05 INFO - Downloading docopt-0.6.1.tar.gz 20:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:05 INFO - Running setup.py install for blobuploader 20:09:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:05 INFO - Running setup.py install for requests 20:09:05 INFO - Running setup.py install for docopt 20:09:06 INFO - Successfully installed blobuploader requests docopt 20:09:06 INFO - Cleaning up... 20:09:06 INFO - Return code: 0 20:09:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:06 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:06 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 20:09:06 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 20:09:06 INFO - Using env: {'DISPLAY': ':0', 20:09:06 INFO - 'HOME': '/home/cltbld', 20:09:06 INFO - 'LANG': 'en_US.UTF-8', 20:09:06 INFO - 'LANGUAGE': 'en_US:en', 20:09:06 INFO - 'LOGNAME': 'cltbld', 20:09:06 INFO - 'MAIL': '/var/mail/cltbld', 20:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:06 INFO - 'MOZ_NO_REMOTE': '1', 20:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:06 INFO - 'NO_EM_RESTART': '1', 20:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:06 INFO - 'PWD': '/builds/slave/test', 20:09:06 INFO - 'SHELL': '/bin/bash', 20:09:06 INFO - 'SHLVL': '1', 20:09:06 INFO - 'TERM': 'linux', 20:09:06 INFO - 'TMOUT': '86400', 20:09:06 INFO - 'USER': 'cltbld', 20:09:06 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:06 INFO - '_': '/tools/buildbot/bin/python'} 20:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:06 INFO - Running setup.py (path:/tmp/pip-S2oOf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:06 INFO - Running setup.py (path:/tmp/pip-MA2x28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:06 INFO - Running setup.py (path:/tmp/pip-89hljs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:06 INFO - Running setup.py (path:/tmp/pip-_jf6Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:06 INFO - Running setup.py (path:/tmp/pip-K884cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:06 INFO - Running setup.py (path:/tmp/pip-dSUtOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:06 INFO - Running setup.py (path:/tmp/pip-5ArjsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:06 INFO - Running setup.py (path:/tmp/pip-Sy6P52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:06 INFO - Running setup.py (path:/tmp/pip-8GV4Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:06 INFO - Running setup.py (path:/tmp/pip-YXeP7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:07 INFO - Running setup.py (path:/tmp/pip-Q5O6iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:07 INFO - Running setup.py (path:/tmp/pip-lo2EHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:07 INFO - Running setup.py (path:/tmp/pip-QZ18r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:07 INFO - Running setup.py (path:/tmp/pip-No3pDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:07 INFO - Running setup.py (path:/tmp/pip-CA5wiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:07 INFO - Running setup.py (path:/tmp/pip-IglH7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:07 INFO - Running setup.py (path:/tmp/pip-oAWTBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:07 INFO - Running setup.py install for manifestparser 20:09:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:07 INFO - Running setup.py install for mozcrash 20:09:07 INFO - Running setup.py install for mozdebug 20:09:07 INFO - Running setup.py install for mozdevice 20:09:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:07 INFO - Running setup.py install for mozfile 20:09:08 INFO - Running setup.py install for mozhttpd 20:09:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozinfo 20:09:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozInstall 20:09:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozleak 20:09:08 INFO - Running setup.py install for mozlog 20:09:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for moznetwork 20:09:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozprocess 20:09:08 INFO - Running setup.py install for mozprofile 20:09:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozrunner 20:09:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozscreenshot 20:09:09 INFO - Running setup.py install for moztest 20:09:09 INFO - Running setup.py install for mozversion 20:09:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:09 INFO - Cleaning up... 20:09:09 INFO - Return code: 0 20:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:09 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:09 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 20:09:09 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 20:09:09 INFO - Using env: {'DISPLAY': ':0', 20:09:09 INFO - 'HOME': '/home/cltbld', 20:09:09 INFO - 'LANG': 'en_US.UTF-8', 20:09:09 INFO - 'LANGUAGE': 'en_US:en', 20:09:09 INFO - 'LOGNAME': 'cltbld', 20:09:09 INFO - 'MAIL': '/var/mail/cltbld', 20:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:09 INFO - 'MOZ_NO_REMOTE': '1', 20:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:09 INFO - 'NO_EM_RESTART': '1', 20:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:09 INFO - 'PWD': '/builds/slave/test', 20:09:09 INFO - 'SHELL': '/bin/bash', 20:09:09 INFO - 'SHLVL': '1', 20:09:09 INFO - 'TERM': 'linux', 20:09:09 INFO - 'TMOUT': '86400', 20:09:09 INFO - 'USER': 'cltbld', 20:09:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:09 INFO - '_': '/tools/buildbot/bin/python'} 20:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:09 INFO - Running setup.py (path:/tmp/pip-q5tqfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:09 INFO - Running setup.py (path:/tmp/pip-ErkHN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:09 INFO - Running setup.py (path:/tmp/pip-psKeIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:09 INFO - Running setup.py (path:/tmp/pip-NZYVKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:09 INFO - Running setup.py (path:/tmp/pip-j4NEs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:09 INFO - Running setup.py (path:/tmp/pip-HrupuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:09 INFO - Running setup.py (path:/tmp/pip-lcPefi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:10 INFO - Running setup.py (path:/tmp/pip-_MVElJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:10 INFO - Running setup.py (path:/tmp/pip-Znrkcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:10 INFO - Running setup.py (path:/tmp/pip-UcFeNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:10 INFO - Running setup.py (path:/tmp/pip-AOFB8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:10 INFO - Running setup.py (path:/tmp/pip-bpguI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:10 INFO - Running setup.py (path:/tmp/pip-d6_vJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:10 INFO - Running setup.py (path:/tmp/pip-ro04SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:10 INFO - Running setup.py (path:/tmp/pip-dID7FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:10 INFO - Running setup.py (path:/tmp/pip-5X9vPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:10 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)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:10 INFO - Running setup.py (path:/tmp/pip-hh_XKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:10 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)) 20:09:10 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)) 20:09:10 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)) 20:09:10 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)) 20:09:10 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)) 20:09:10 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)) 20:09:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:12 INFO - Downloading blessings-1.6.tar.gz 20:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:12 INFO - Installing collected packages: blessings 20:09:12 INFO - Running setup.py install for blessings 20:09:12 INFO - Successfully installed blessings 20:09:12 INFO - Cleaning up... 20:09:12 INFO - Return code: 0 20:09:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:13 INFO - Reading from file tmpfile_stdout 20:09:13 INFO - Current package versions: 20:09:13 INFO - argparse == 1.2.1 20:09:13 INFO - blessings == 1.6 20:09:13 INFO - blobuploader == 1.2.4 20:09:13 INFO - docopt == 0.6.1 20:09:13 INFO - manifestparser == 1.1 20:09:13 INFO - mozInstall == 1.12 20:09:13 INFO - mozcrash == 0.17 20:09:13 INFO - mozdebug == 0.1 20:09:13 INFO - mozdevice == 0.48 20:09:13 INFO - mozfile == 1.2 20:09:13 INFO - mozhttpd == 0.7 20:09:13 INFO - mozinfo == 0.9 20:09:13 INFO - mozleak == 0.1 20:09:13 INFO - mozlog == 3.1 20:09:13 INFO - moznetwork == 0.27 20:09:13 INFO - mozprocess == 0.22 20:09:13 INFO - mozprofile == 0.28 20:09:13 INFO - mozrunner == 6.11 20:09:13 INFO - mozscreenshot == 0.1 20:09:13 INFO - mozsystemmonitor == 0.0 20:09:13 INFO - moztest == 0.7 20:09:13 INFO - mozversion == 1.4 20:09:13 INFO - psutil == 3.1.1 20:09:13 INFO - requests == 1.2.3 20:09:13 INFO - wsgiref == 0.1.2 20:09:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:13 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:13 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 20:09:13 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 20:09:13 INFO - Using env: {'DISPLAY': ':0', 20:09:13 INFO - 'HOME': '/home/cltbld', 20:09:13 INFO - 'LANG': 'en_US.UTF-8', 20:09:13 INFO - 'LANGUAGE': 'en_US:en', 20:09:13 INFO - 'LOGNAME': 'cltbld', 20:09:13 INFO - 'MAIL': '/var/mail/cltbld', 20:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:13 INFO - 'MOZ_NO_REMOTE': '1', 20:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:13 INFO - 'NO_EM_RESTART': '1', 20:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:13 INFO - 'PWD': '/builds/slave/test', 20:09:13 INFO - 'SHELL': '/bin/bash', 20:09:13 INFO - 'SHLVL': '1', 20:09:13 INFO - 'TERM': 'linux', 20:09:13 INFO - 'TMOUT': '86400', 20:09:13 INFO - 'USER': 'cltbld', 20:09:13 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:13 INFO - '_': '/tools/buildbot/bin/python'} 20:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 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)) 20:09:13 INFO - Cleaning up... 20:09:13 INFO - Return code: 0 20:09:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:13 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 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:13 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 20:09:13 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 20:09:13 INFO - Using env: {'DISPLAY': ':0', 20:09:13 INFO - 'HOME': '/home/cltbld', 20:09:13 INFO - 'LANG': 'en_US.UTF-8', 20:09:13 INFO - 'LANGUAGE': 'en_US:en', 20:09:13 INFO - 'LOGNAME': 'cltbld', 20:09:13 INFO - 'MAIL': '/var/mail/cltbld', 20:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:13 INFO - 'MOZ_NO_REMOTE': '1', 20:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:13 INFO - 'NO_EM_RESTART': '1', 20:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:13 INFO - 'PWD': '/builds/slave/test', 20:09:13 INFO - 'SHELL': '/bin/bash', 20:09:13 INFO - 'SHLVL': '1', 20:09:13 INFO - 'TERM': 'linux', 20:09:13 INFO - 'TMOUT': '86400', 20:09:13 INFO - 'USER': 'cltbld', 20:09:13 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:13 INFO - '_': '/tools/buildbot/bin/python'} 20:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:13 INFO - Downloading/unpacking jsonschema 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:15 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:15 INFO - warning: no files found matching '*.txt' 20:09:15 INFO - no previously-included directories found matching 'build' 20:09:15 INFO - no previously-included directories found matching 'dist' 20:09:15 INFO - no previously-included directories found matching '.git*' 20:09:15 INFO - Installing collected packages: jsonschema, functools32 20:09:15 INFO - Running setup.py install for functools32 20:09:16 INFO - warning: no files found matching '*.txt' 20:09:16 INFO - no previously-included directories found matching 'build' 20:09:16 INFO - no previously-included directories found matching 'dist' 20:09:16 INFO - no previously-included directories found matching '.git*' 20:09:16 INFO - Successfully installed jsonschema functools32 20:09:16 INFO - Cleaning up... 20:09:16 INFO - Return code: 0 20:09:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaafbfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', '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 20:09:16 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', 'flake8'] in /builds/slave/test/build 20:09:16 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 flake8 20:09:16 INFO - Using env: {'DISPLAY': ':0', 20:09:16 INFO - 'HOME': '/home/cltbld', 20:09:16 INFO - 'LANG': 'en_US.UTF-8', 20:09:16 INFO - 'LANGUAGE': 'en_US:en', 20:09:16 INFO - 'LOGNAME': 'cltbld', 20:09:16 INFO - 'MAIL': '/var/mail/cltbld', 20:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:16 INFO - 'MOZ_NO_REMOTE': '1', 20:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:16 INFO - 'NO_EM_RESTART': '1', 20:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:16 INFO - 'PWD': '/builds/slave/test', 20:09:16 INFO - 'SHELL': '/bin/bash', 20:09:16 INFO - 'SHLVL': '1', 20:09:16 INFO - 'TERM': 'linux', 20:09:16 INFO - 'TMOUT': '86400', 20:09:16 INFO - 'USER': 'cltbld', 20:09:16 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:16 INFO - '_': '/tools/buildbot/bin/python'} 20:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:16 INFO - Downloading/unpacking flake8 20:09:16 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 20:09:16 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 20:09:16 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 20:09:16 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 20:09:16 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 20:09:16 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 20:09:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:18 INFO - no previously-included directories found matching 'docs/_build' 20:09:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:18 INFO - Running setup.py install for pep8 20:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:18 INFO - no previously-included directories found matching 'docs/_build' 20:09:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:09:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:19 INFO - Cleaning up... 20:09:19 INFO - Return code: 0 20:09:19 INFO - Running post-action listener: _resource_record_post_action 20:09:19 INFO - Running post-action listener: _start_resource_monitoring 20:09:19 INFO - Starting resource monitoring. 20:09:19 INFO - ##### 20:09:19 INFO - ##### Running install step. 20:09:19 INFO - ##### 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: install 20:09:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:19 INFO - Reading from file tmpfile_stdout 20:09:19 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:19 INFO - Reading from file tmpfile_stdout 20:09:19 INFO - Output received: 20:09:19 INFO - Usage: mozinstall [options] installer 20:09:19 INFO - Options: 20:09:19 INFO - -h, --help show this help message and exit 20:09:19 INFO - -d DEST, --destination=DEST 20:09:19 INFO - Directory to install application into. [default: 20:09:19 INFO - "/builds/slave/test"] 20:09:19 INFO - --app=APP Application being installed. [default: firefox] 20:09:19 INFO - mkdir: /builds/slave/test/build/application 20:09:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:09:35 INFO - Reading from file tmpfile_stdout 20:09:35 INFO - Output received: 20:09:35 INFO - /builds/slave/test/build/application/firefox/firefox 20:09:35 INFO - Running post-action listener: _resource_record_post_action 20:09:35 INFO - ##### 20:09:35 INFO - ##### Running run-tests step. 20:09:35 INFO - ##### 20:09:35 INFO - Running pre-action listener: _resource_record_pre_action 20:09:35 INFO - Running main action method: run_tests 20:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:35 INFO - Python 2.7.3 20:09:35 INFO - Return code: 0 20:09:35 INFO - grabbing minidump binary from tooltool 20:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:35 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7810>, '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 0x1df8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:35 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 20:09:35 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 20:09:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:36 INFO - Return code: 0 20:09:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:09:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:09:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:09:36 INFO - Return code: 0 20:09:36 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://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 20:09:36 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://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 20:09:36 INFO - Using env: {'DISPLAY': ':0', 20:09:36 INFO - 'HOME': '/home/cltbld', 20:09:36 INFO - 'LANG': 'en_US.UTF-8', 20:09:36 INFO - 'LANGUAGE': 'en_US:en', 20:09:36 INFO - 'LOGNAME': 'cltbld', 20:09:36 INFO - 'MAIL': '/var/mail/cltbld', 20:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:36 INFO - 'MOZ_NO_REMOTE': '1', 20:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:36 INFO - 'NO_EM_RESTART': '1', 20:09:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:36 INFO - 'PWD': '/builds/slave/test', 20:09:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:36 INFO - 'SHELL': '/bin/bash', 20:09:36 INFO - 'SHLVL': '1', 20:09:36 INFO - 'TERM': 'linux', 20:09:36 INFO - 'TMOUT': '86400', 20:09:36 INFO - 'USER': 'cltbld', 20:09:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583', 20:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:36 INFO - '_': '/tools/buildbot/bin/python'} 20:09:36 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://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 20:09:37 INFO - mozversion application_buildid: 20160428173013 20:09:37 INFO - mozversion application_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 20:09:37 INFO - mozversion application_display_name: Nightly 20:09:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:37 INFO - mozversion application_name: Firefox 20:09:37 INFO - mozversion application_remotingname: firefox 20:09:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:09:37 INFO - mozversion application_vendor: Mozilla 20:09:37 INFO - mozversion application_version: 49.0a1 20:09:37 INFO - mozversion platform_buildid: 20160428173013 20:09:37 INFO - mozversion platform_changeset: 98aa054d9e2757e43158b0c962be9cbab784e9e2 20:09:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:09:37 INFO - mozversion platform_version: 49.0a1 20:09:37 INFO - using testdate: 1461899377 20:09:37 INFO - actual date: 1461899377 20:09:37 INFO - starting webserver on 'localhost:54297' 20:09:37 INFO - SUITE-START | Running 2 tests 20:09:37 INFO - TEST-START | dromaeo_css 20:09:37 INFO - operating with platform_type : linux_ 20:09:37 INFO - Initialising browser for dromaeo_css test... 20:09:37 INFO - TEST-INFO | started process 13072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfuzGY/profile http://localhost:54297/getInfo.html) 20:09:41 INFO - PROCESS | 13072 | __metrics Screen width/height:1600/1200 20:09:41 INFO - PROCESS | 13072 | colorDepth:24 20:09:41 INFO - PROCESS | 13072 | Browser inner width/height: 1024/697 20:09:41 INFO - PROCESS | 13072 | __metrics 20:09:42 ERROR - PROCESS | 13072 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:09:43 INFO - TEST-INFO | 13072: exit 0 20:09:43 INFO - Browser initialized. 20:09:43 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:43 INFO - TEST-INFO | started process 13154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfuzGY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:55 INFO - PROCESS | 13154 | RSS: Main: 154112000 20:09:55 INFO - PROCESS | 13154 | 20:10:46 INFO - PROCESS | 13154 | 1461899446517 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] 20:12:54 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54297/tests/dromaeo/cssquery-ext.html) 20:12:55 INFO - PROCESS | 13154 | RSS: Main: 283316224 20:12:55 INFO - PROCESS | 13154 | 20:15:57 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-ext.html (next: http://localhost:54297/tests/dromaeo/cssquery-jquery.html) 20:15:58 INFO - PROCESS | 13154 | RSS: Main: 237936640 20:15:58 INFO - PROCESS | 13154 | 20:18:59 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54297/tests/dromaeo/cssquery-mootools.html) 20:19:00 INFO - PROCESS | 13154 | RSS: Main: 236888064 20:19:00 INFO - PROCESS | 13154 | 20:22:02 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54297/tests/dromaeo/cssquery-prototype.html) 20:22:03 INFO - PROCESS | 13154 | RSS: Main: 232660992 20:22:03 INFO - PROCESS | 13154 | 20:25:05 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54297/tests/dromaeo/cssquery-yui.html) 20:25:06 INFO - PROCESS | 13154 | RSS: Main: 219353088 20:25:06 INFO - PROCESS | 13154 | 20:28:08 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-yui.html (next: http://localhost:54297/tests/dromaeo/cssquery-dojo.html) 20:28:08 INFO - PROCESS | 13154 | RSS: Main: 266432512 20:28:08 INFO - PROCESS | 13154 | 20:28:08 INFO - PROCESS | 13154 | __start_tp_report 20:28:08 INFO - PROCESS | 13154 | _x_x_mozilla_page_load 20:28:09 INFO - PROCESS | 13154 | _x_x_mozilla_page_load_details 20:28:09 INFO - PROCESS | 13154 | |i|pagename|runs| 20:28:09 INFO - PROCESS | 13154 | |0;dojo.html;3105.6739042400545;3152.4325621388143;3185.092248709117;3187.888423905162;3213.887513937012;5160.664556803805;5258.13240815266;5264.842054738359;5300.178472336789;5406.135018397053;5226.738663066841;5313.946860531393;5361.437049109846;5368.033753924302;5369.838904832861;4704.38842950416;4769.928451073237;4887.853364399074;4925.359703238574;4963.72699501529;4868.637519318008;4885.364902562662;4900.387451568554;4921.138800709879;4924.975375123119;4689.132510485571;4748.97625511872;4761.952380476203;4767.165745994437;4771.427428708577;4740.786664600101;4817;4883.609311255091;4898.191798353268;4906.435759887623;4720.811167553328;4723.385959825235;4752.7623618818925;4769.070031343889;4798.568128868384;5139.460356662571;5143.5113664201845;5143.8456846294675;5161.612879034087;5188.6367954243215;5335.733213339357;5548.195511650828;5581;5623.325200975868;5648.209250704905;5556.972215138939;5589.888202235932;5595.18869763882;5608.327000759894;5622.887542249132;5117.8720531987;5212.843614691566;5216;5226.608004399647;5229.816956406507;5756.107803290497;5814.476697097197;5815.069588865846;5870.236869207061;5892.234009578728;5440.238366628675;5445.754941027663;5453.863653408617;5455.754491047833;5457.426970168075;5435.0488664483555;5486.396496385394;5524.723763811793;5533.08704063833;5534.05920993424;5572;5575.581831362664;5577.498025177753;5617.691026993554;5626.1842032905;5571.303587051619;5575.721213939287;5576.358718747315;5577.079781836032;5584.329880414376;4229.915401691949;4240.38514415408;4281.957180428218;4300.053988122608;4338.76136812472;3775.811209439572;3778.3954567269657;3779.905502362463;3810.48558444612;3815.294170578452;5238.92141617876;5261.631685782035;5264.341957255343;5266.0257852297445;5267.604929630293;5453.863653408696;5609.747561359749;5667.971660141673;5733.598648094677;5740.483356497935;5165.302684137669;5193.039287731782;5202.661826981234;5206.140986737221;5212.739363031833;4703.7883295251795;4735.739534325645;4735.786889589976;4737.692050016738;4771.427428708508;5712.6286791358425;5745.052066408995;5753.280839895013;5800.419958004166;5804.390538993429;5683.801066962719;5722.341930678025;5724.227229323988;5726.656400615976;5737.426257374229;5752.9712351437975;5795.072788353843;5861;5890.175375447355;5901.970490147522;5522;5534.501894829485;5536.7231638418725;5559.499645031967;5584.162375643686;5604.551635869202;5605.439456054362;5606.943930560806;5607.495325420732;5630.4369563043365;5353.170258609922;5488.396276409512;5536.889262214652;5549.611527193058;5591.9720401397735;5453.945460545502;5460.26286451324;5464;5467.753951072132;5494.697791621339;5345.839624811262;5365.490278423544;5378.327709036371;5382.219578161223;5426;5347.358317001985;5489.64317319373;5526.91709624364;5615;5637.041702910433;5226.398964119023;5359.115745902039;5380.9730951346555;5382.058139825594;5436.429174936575 20:28:09 INFO - PROCESS | 13154 | |1;ext.html;573.7991702903984;618.4248648756657;621.1614320667097;625.4996003197441;632.8069938668707;30173;30564.847175764116;30680.84659576699;30688.23279418013;30700;38084.80957595215;39555.802220988924;39634.8018259909;39639.60360396395;39667.801660991725;8570.65717371306;8882.86675699865;8906.02033776284;8915.643374265022;8917.643294268222;8679.21887030167;8840.823183536326;8854.822903541924;8858.911410885874;8859.468431894074;8825.426347287406;8867.600957956874;8886.688965886195;8894.555272236395;8895.199432051115;8781.912180878206;8828.911710882938;8843.336749743763;8844.778880528007;8852.159044890725;8839.29285657146;8953.686620968236;8955.596998135099;8956.104389561056;8963;40537.189256215;41061.38407923884;41119.383209251886;41182;41190.588094118975;3428.7428442866635;3580.982095089534;3769.246150769857;3938.5425117235955;4235.1529694061;31334;31543.36913261745;31826.522602160985;32235.677643223502;32518.349633007445;4250.468691413574;4365.738055716635;4381.605655491021;4390.824367025315;4404.603585677304;320835;321027;321431;321432.9999999977;321556;44488.77755611266;50205;55452.44547554554;55626;55783.72108139433;52563.73718131462;52814;52836.47163528315;52845;52975.47024529782;15914.76127858083;16162.191890405433;16164;16177.272022759003;16180.19099045043;11727;12788.808167877489;13021;13061.673458163432;13122.737545249041;15885.523434296989;16002.439914603166;16048.117353545433;16076;16088.839111608968;6365.267994180728;6520.902186467207;6534.640594767334;6600.059946048595;6630.336966303331;1008.5713571731984;1061.474570087796;1077.8652668416448;1114.0753174864842;1148.782849101226;32282.83858580692;32820.83589582037;32855;32900;33376.49935250973;1124.5951457475303;1136.4261048170622;1160.3154139057997;1186.685528334992;1282.1153404151105;17151;17309.7403538947;17362.739558906625;17481.650366992588;17584.362345647998;470027;474885;476340;476643;479435;56703.71648141815;57121;57401;57509.424905750406;57535.42464575385;1393.1989106263939;1395.6092294157652;1398.8461269260374;1428.2358937968345;1511.508759653117;28173.154805355873;29139.854300728362;31477;31779.841100794347;32040.67959320377;39985.2002959945;40869;40978.59021409748;41090.79454602708;41107;282620;287485;288245;288982;289830;31346.686533134376;35365.646343537264;36918.44622330721;36924.81537592402;37017.62982370142;40628.59371406248;42351.57648423476;44559.777201113786;45341.69253920872;46543.53456465392;37456.81271593625;37646;38322;38755.80622096984;39953.2009359817;38039.429408559445;38163;38209.80895095507;38340.424893627176;38674.6132538671;36101.81949090238;37052.25895482129;37091.629083708816;37146.07134821543;39677.404838926865;32781.83609081939;34100;34126.65873341235;34203;34462;24691.135810247273;25628.871855640602;27160.456790864468;27193.45613087767;27194 20:28:09 INFO - PROCESS | 13154 | |2;jquery.html;374.1320137281507;374.4439507331612;376.1442717816966;380.5338460386029;383.98464061437545;17841.28634854606;18014;18827.811721882776;19050.618987620255;19055.42833714987;11273.492692828822;11346.60286889959;11555.826662600046;11706.414679266045;11715.472803723831;4672.345871577982;5744.368119506872;5745;5746.051901436258;5750.884982300351;5477.945220547784;5544.279243698314;5681.977244096061;5719.770249396379;5722.084466485363;5625.099984002561;5660.716964151797;5682.488576028157;5685.374608793029;5685.715714214272;5161.148410512261;5378.327709036371;5647.181158731982;5648.322201335845;5652.208690783294;4870.975645121752;4994.2508623706735;5027.245913113025;5047.64666473347;5049.141645920203;12643.49426022958;12765;19469.902650486798;21997.340079797632;22029.66955495669;2230.5984922713906;2357.210334537932;2358.3526227874845;2421.769931856471;2738.5070687276284;9339.112784285482;10256.38461692301;13299.069065165442;14354.569362919128;14644.41422343105;1923.9923833703592;1992.1334219614514;2029.4317591074523;2054.281001649426;2107.2787382257247;57643;70630.64684676596;72794;76018.23981760167;80763;9703.854442183372;9739.172170365457;9938.850917236246;10076.596936122472;10179.389236645677;13969.371378288002;14066.43734250639;14094.436222550983;14140.717185656435;14141.787873181911;7893.960530197427;7968.641411136513;7968.641411136513;8001;8059.314958228499;7709.42179336552;7796.961015195001;7905.920940790634;7963.920360796434;7985.720499782596;4451.5325890781005;4465.330200469955;4494.348319493655;4501.234790085693;4508.278675411918;1865.3564520240495;1879.9530011749541;1906.428071578521;1915.4923945154544;1935.2645994521993;940.3370623710268;1009.9848502272472;1053.320608207717;1077.5312738958578;1078.44460103047;17593.7360939586;18455.90772046158;18700.625987480173;18750;18960.43118706441;1023.2785885950387;1036.9066783989476;1052.768390953989;1070.2454769387564;1073.75303680154;10122.443265620313;10584.682459526226;10616.946915265375;10670.46647667629;10741.51663175159;466783;482058;487854;489594;490805;79624;87315;90039.54980225056;90044;90152;983.4345251480428;986.4475893499663;1001.8447140693204;1005.2711783956573;1006.5189308354941;15766.448174313844;16435.753463697816;16522.83477165213;16725.49823505248;16978.915105424392;29812.701872980993;36378.636213637525;36500.269994599425;37087.629123708415;38206.044848877886;52657.736711316196;54472;56246.43753562576;56516.43483565276;57026.714866425405;7765.1846556110795;8103.716369927024;8618.698345557876;8638.26574741154;8645.654173832976;8403;8851.424657397249;10669.879662635622;12748.553800616934;13088.28014459214;11653.41732913368;11792;12117.454714537691;12328.383580821102;12502.87497125017;11509;11818;11927.46326415296;11990.220635658654;12353.38233088324;5942.584019118794;8889.4666320021;11080.5567777288;12079.154459188125;12105.394730263628;8398.538080405637;8438.789030274047;8454.32365410778;8566.957165214135;8598;8647.919010123735;11821.822672659744;11911.583094591648;12344.567940122053;12410.5656302029 20:28:09 INFO - PROCESS | 13154 | |3;mootools.html;1325.2181213084277;1446.7974483572298;1498.5204734484962;1585.3500064973364;1731.5324862287175;7937.08723496798;8271.586420678957;8289.253967142957;8291.709790157345;8299.211574900382;8042.597870106486;8215.671373145082;8225.012998440181;8233.794155146124;8246.628901699423;2005.979940200594;2242.338510139513;2264.3320220534943;2303.6429353450244;2322.1640209524558;2285.542891421714;2300.321405185466;2300.5858945389823;2301.2520930697506;2301.631738921773;2285.9771402286015;2289.267434420986;2331.1957374705785;2333.88330583471;2335.94160145996;1952.5899561092187;2031.3804289691639;2160.3518944316643;2210.4694873230387;2228.687983682286;2208.2491952736145;2224.9777502225093;2231.787980141884;2235.0501037059184;2235.2847088931385;8203.917960820376;8264.545450000247;8271.710490132817;8273.46222495536;8273.544955027472;4701;4846.75766211688;4857.951420485785;4860.538248866387;4898.632602554787;2982.239528920133;3027.3945210957677;3153.180173154973;3153.5112057631104;3194.5847039884666;950.9144177024032;951.3831303285632;957.5834511987308;988.5353883674661;992.9751756206081;11459.19785614999;11467.942660286646;11469.88530114705;11503.482343294572;11581.652550423416;4169.1661667666585;4187.937180942288;4296.656267498593;4304.461942257218;4336.436263285753;9595.952020239854;9624.133827955518;9631.662891798753;9644.662436814679;9701.320907536547;4926.359573255526;4949.90100197994;4953.6037117030555;4962.181240095416;4965.751712414365;4078.4494093297617;4442.289233722653;4549.6360291176625;4558.680892337505;4562.9771851141195;3663.8900832975055;3664.706823454117;3737.682297004785;3752.981235093807;3776.263628592453;1117.8379135025375;1175.7589694112858;1181.0945075115312;1184.6682928779956;1191.3745283725939;875.6191056890273;887.8978917424579;905.2169873059756;923.007766650853;930.8882934047957;5733.799317023968;5895.233619629506;5937.732802023919;5938.61399009063;6148.477379422709;933.6265493802398;965.3773316211004;972.3582435592475;996.8155891160159;1030.5362586835954;3853.7880416576795;3873.24471728016;3980.8805735827973;4014.9397759033636;4079.408485769606;9782.168515676105;10126.645567405252;10209.285350025575;10220.488975551192;10267.435291058913;9897.950510247547;10144.949275253577;10213.489325533694;10214.795704085876;10239.948800255952;7317.195108538057;7506.587137707369;7605.961970190114;7612.961935190288;7772.300492955661;5608.495235428831;5614;5660.122680984454;5661.207430959586;5805.622634528742;9496.667616633385;9556.665516706882;9654.227661787181;9666;9755.268354873271;9152.17630413266;9383.34316597859;9656.565454554702;9660.420374777535;9744.512774361112;6562.77030303937;6963.7214511421;7138.321859423347;7157.821054473679;7358.484906056525;7920.168382320004;7948.244916732901;7982.401319901147;8003.31971782405;8024.478408903403;7057.858842823218;7265.273472652904;7299.489035767658;7310.817229569303;7445.4043676506835;7231.204567497466;7256.346928776436;7362.3741981932135;7463.626818659154;7531.510451820614;6753.3921947025;6778.491613129134;6795.898061528982;6803.489738269748;6829.351211634887;4909.361782968192;5038.622103342191;5060.468650791614;5074.746262686925;5075.949240507695;5012.949870501248;5093.286939828353;5126.307948426915;5174;5212.582993360598 20:28:09 INFO - PROCESS | 13154 | |4;prototype.html;309.41983780411726;320.0526441732472;320.55122828040726;323.04379038047387;323.2613478202308;5122.513361230677;5208.114620514512;5296.682199068054;5348.304720386354;5381.919271210935;5231.189165679316;5235.58115350772;5279.604029697769;5284.735763211834;5294.094126114605;4119.691023173259;4130.13267213884;4144.979275103636;4170.499540055198;4179.9373009404735;3910.1984093260958;3945.881623551298;4124.319487284594;4144.316187829005;4153.480814898137;4067.9796601016956;4082.326416141348;4084.2852500812387;4092.7339722918064;4109.445224894631;4050.8177132029127;4079.1433798902267;4110.424540564323;4114.280000999828;4114.341705327163;3546.8758593449365;3603.783772973604;3623.5289412376487;3630.6550877666577;3641.289948460051;5054.620903432257;5056.949430505685;5058.392992840846;5071.54356107952;5096.898062038738;4572.177008138534;4652.674312798105;4659.5573420525;4664.836730714409;4674.275487299474;5238.633295669305;5415.593830462692;5423.376311724162;5464.502718260277;5474.671519708831;3918.6865050796155;3930.8231129599235;3932.6264004919485;3936.704747143947;3946.605339466059;5715.685637289947;5718.227349521661;5722.914156287659;5740.737037851666;5742.167385729088;4048.817803198804;4053.0880551875593;4065.6380112662;4070.8371665133654;4078.0620457294394;3833.6933045356304;4016.49793775778;4017.6183262590007;4019.3769965654787;4028.959710402917;4606.608438282784;4622.405270181782;4629.421322334708;4630.768461576908;4632.490426053131;5585.843998141037;5588.21764952907;5598.496135347838;5599.60802743804;5627.634203776742;1365.208179256029;1409.3587417724912;1445.075151902762;1447.073872721459;1447.8127935093123;941.1623654947102;942.2179590939504;949.9572519236513;954.3224310739314;966.4974213408988;5682.886342273131;5684.8294551163535;5701.40135285789;5708.514776243983;5715.31416230055;6041.879162416815;6050.3949605040025;6057.9403002978315;6058.303295121029;6062.878742425215;5477.67133971963;5514.531264842453;5575.4424557543925;5597.328320601554;5665.2635157430095;3185.3629274145264;3200;3204.3591281743743;3210.4381733196597;3219.197249540265;6152.630842149485;6236.812895613139;6256.436920677161;6259.2488901332135;6276.121343011982;6157.907631385443;6175.536834737412;6178.219801089528;6195.504359651217;6204.968975155095;6226.937730622726;6244.12582238487;6269.153664255267;6269.68651567429;6270.717817698214;5779.162021506942;6009.2188015557695;6023.1567580537885;6033.215681961317;6036.245469316335;5880.029795083934;5920.851978700567;5943.197668314722;5953.553483488669;6012.609180403259;5996.730147143477;6226.875462490634;6227.699319360746;6229.937700622936;6247.375262473716;4104.220198162339;4135.110951145518;4142.378643203544;4142.399352093869;4153.086321009373;5367.497100811779;6014.759409623566;6027.9806264901745;6037;6056.485198758155;5314.654547454403;5553.555715542666;5562.582806289625;5569.582281328998;5585.162225666182;5529.364123125892;5532.75102620375;5543.584231182596;5546.611737178358;5551.333839939233;5124.769385377593;5307.389650190277;5441.5102640762525;5443.891122177455;5511.972440137934;5555.472230138131;5576.275084239023;5583.804566840141;5587.217789509391;5593.692346920959;5454.372747134131;5467.125259958388;5474.288342515607;5476.7535460903555;5500.202470641814 20:28:09 INFO - PROCESS | 13154 | |5;yui.html;709.4643544124186;709.8651256261312;741.6884908338498;765.4527013185572;826.9958650206748;14240.928795356022;14697.26513674316;14702.264886755673;15417;15854.048757074585;14784.926075369634;14860.47988320409;14877.479288224915;14943.327550260237;15009.774853377181;683.7777722240266;802.1016461563057;820.216693058128;824.2952275804191;826.4421515477059;800.6997375984006;813.1218284252992;815.213319147023;816.9714060007901;817.358373676664;852.2457625001856;853.871919212117;854.218390172991;854.2439940652537;854.4616891358436;708.348319546019;835.6072645856468;859.1837754133567;859.8065435277075;860.5568132411751;625.3808729357949;625.9843503912393;627.5356236385088;629.3706293706293;631.28664608992;13624.250666213453;13875.653108672263;13878.653033674138;13878.930605346908;13903.096298740651;13094.672633184151;13572;13589.932050339783;13671.384787684578;13839.308034598229;10489.423081730502;10742.355458672504;10752.354858708424;11348.262362946381;11577.479013444416;4455.777211139462;4463.107378524276;4466.70966387187;4538.931916021263;4610.769461526944;47025.5297447028;47392;47459;47767.28349074732;47805.28292075587;9730.36752611078;9968.252381071448;10162.4918754062;10493.108085812639;10613.681589552325;18260.543486412946;18267.36064237772;18300.450986470427;18394.17226224823;18428.815711842977;7910.2089791020435;7919.6832126715435;8005.799855003672;8078.35373170145;8166;4840.467548569725;4876.975615121902;4967.5777558907175;4980.526849949249;4992.825251116194;3369.3261347730554;3395.3888300105723;3417.179876829543;3441.8623255069515;3449.5170676105367;604.6341963112342;614.529884638252;650.2846868444673;656.0389030070969;660.3561527510639;698.7135274537517;716.8100453379858;735.8565079809492;741.0921621014214;756.0964647246598;8487.533185674723;8871.373553282527;8956.238719708768;9013.098690131066;9209.401388909699;705.9682314295869;719.8776208044645;732.7105793211651;735.1582438108443;739.6893304811991;4245.087306229114;4312.180685669713;4356.847510337123;4449.777511124431;4528.0943811237885;67826.66086669535;70446.29553704397;70919.2908070923;71359;71361;56221;57537;59043.40956590465;61099.38900610937;62025.37974620196;51596.74201628968;51854.48145518496;56978.43021569814;57585;57644.71177644169;8438.240558349778;8637.740867773977;8640;8685.696000639948;8855;35391.46912796362;36039.63960360468;36326.09184770402;36351.45472817857;36925.07687307839;46636.7668161657;49928.25107623316;50157;50159.24761128513;50261.74869125631;10655.200859935381;10825.783484330426;10853.077488413574;10893.291936024134;10974.341539507655;12110.878891210976;12305.384730763248;12382.442790074649;12410.503579856704;12460.626181214579;9404.95297523508;11167.664970050912;11468.827967580326;11801.409929503663;11926.821097683369;11739.11956603241;11785.88214117848;11916.285022898654;11978.221415607957;12089.274643521418;11310.321380716854;11442.084633229155;11471;11555.306681599131;11765.588204412805;9741.80516389654;9921.851172232567;10021.39871607706;10102.191824653863;10199.643012494527;9583.952080239555;9847.901520984986;9856.753581160528;9867.111959923353;9892 20:28:09 INFO - PROCESS | 13154 | __end_tp_report 20:28:09 INFO - PROCESS | 13154 | __start_cc_report 20:28:09 INFO - PROCESS | 13154 | _x_x_mozilla_cycle_collect,1018 20:28:09 INFO - PROCESS | 13154 | __end_cc_report 20:28:09 INFO - PROCESS | 13154 | __startTimestamp1461900488996__endTimestamp 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | ------- Summary: start ------- 20:28:09 INFO - PROCESS | 13154 | Number of tests: 6 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#0] dojo.html Cycles:165 Average:5210.40 Median:5380.97 stddev:577.91 (10.7%) stddev-sans-first:555.59 20:28:09 INFO - PROCESS | 13154 | Values: 3105.7 3152.4 3185.1 3187.9 3213.9 5160.7 5258.1 5264.8 5300.2 5406.1 5226.7 5313.9 5361.4 5368.0 5369.8 4704.4 4769.9 4887.9 4925.4 4963.7 4868.6 4885.4 4900.4 4921.1 4925.0 4689.1 4749.0 4762.0 4767.2 4771.4 4740.8 4817.0 4883.6 4898.2 4906.4 4720.8 4723.4 4752.8 4769.1 4798.6 5139.5 5143.5 5143.8 5161.6 5188.6 5335.7 5548.2 5581.0 5623.3 5648.2 5557.0 5589.9 5595.2 5608.3 5622.9 5117.9 5212.8 5216.0 5226.6 5229.8 5756.1 5814.5 5815.1 5870.2 5892.2 5440.2 5445.8 5453.9 5455.8 5457.4 5435.0 5486.4 5524.7 5533.1 5534.1 5572.0 5575.6 5577.5 5617.7 5626.2 5571.3 5575.7 5576.4 5577.1 5584.3 4229.9 4240.4 4282.0 4300.1 4338.8 3775.8 3778.4 3779.9 3810.5 3815.3 5238.9 5261.6 5264.3 5266.0 5267.6 5453.9 5609.7 5668.0 5733.6 5740.5 5165.3 5193.0 5202.7 5206.1 5212.7 4703.8 4735.7 4735.8 4737.7 4771.4 5712.6 5745.1 5753.3 5800.4 5804.4 5683.8 5722.3 5724.2 5726.7 5737.4 5753.0 5795.1 5861.0 5890.2 5902.0 5522.0 5534.5 5536.7 5559.5 5584.2 5604.6 5605.4 5606.9 5607.5 5630.4 5353.2 5488.4 5536.9 5549.6 5592.0 5453.9 5460.3 5464.0 5467.8 5494.7 5345.8 5365.5 5378.3 5382.2 5426.0 5347.4 5489.6 5526.9 5615.0 5637.0 5226.4 5359.1 5381.0 5382.1 5436.4 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#1] ext.html Cycles:180 Average:52023.90 Median:38123.90 stddev:97882.47 (256.7%) stddev-sans-first:98080.83 20:28:09 INFO - PROCESS | 13154 | Values: 573.8 618.4 621.2 625.5 632.8 30173.0 30564.8 30680.8 30688.2 30700.0 38084.8 39555.8 39634.8 39639.6 39667.8 8570.7 8882.9 8906.0 8915.6 8917.6 8679.2 8840.8 8854.8 8858.9 8859.5 8825.4 8867.6 8886.7 8894.6 8895.2 8781.9 8828.9 8843.3 8844.8 8852.2 8839.3 8953.7 8955.6 8956.1 8963.0 40537.2 41061.4 41119.4 41182.0 41190.6 3428.7 3581.0 3769.2 3938.5 4235.2 31334.0 31543.4 31826.5 32235.7 32518.3 4250.5 4365.7 4381.6 4390.8 4404.6 320835.0 321027.0 321431.0 321433.0 321556.0 44488.8 50205.0 55452.4 55626.0 55783.7 52563.7 52814.0 52836.5 52845.0 52975.5 15914.8 16162.2 16164.0 16177.3 16180.2 11727.0 12788.8 13021.0 13061.7 13122.7 15885.5 16002.4 16048.1 16076.0 16088.8 6365.3 6520.9 6534.6 6600.1 6630.3 1008.6 1061.5 1077.9 1114.1 1148.8 32282.8 32820.8 32855.0 32900.0 33376.5 1124.6 1136.4 1160.3 1186.7 1282.1 17151.0 17309.7 17362.7 17481.7 17584.4 470027.0 474885.0 476340.0 476643.0 479435.0 56703.7 57121.0 57401.0 57509.4 57535.4 1393.2 1395.6 1398.8 1428.2 1511.5 28173.2 29139.9 31477.0 31779.8 32040.7 39985.2 40869.0 40978.6 41090.8 41107.0 282620.0 287485.0 288245.0 288982.0 289830.0 31346.7 35365.6 36918.4 36924.8 37017.6 40628.6 42351.6 44559.8 45341.7 46543.5 37456.8 37646.0 38322.0 38755.8 39953.2 38039.4 38163.0 38209.8 38340.4 38674.6 36101.8 37052.3 37091.6 37146.1 39677.4 32781.8 34100.0 34126.7 34203.0 34462.0 24691.1 25628.9 27160.5 27193.5 27194.0 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#2] jquery.html Cycles:180 Average:27602.22 Median:36793.95 stddev:79563.42 (216.2%) stddev-sans-first:79760.35 20:28:09 INFO - PROCESS | 13154 | Values: 374.1 374.4 376.1 380.5 384.0 17841.3 18014.0 18827.8 19050.6 19055.4 11273.5 11346.6 11555.8 11706.4 11715.5 4672.3 5744.4 5745.0 5746.1 5750.9 5477.9 5544.3 5682.0 5719.8 5722.1 5625.1 5660.7 5682.5 5685.4 5685.7 5161.1 5378.3 5647.2 5648.3 5652.2 4871.0 4994.3 5027.2 5047.6 5049.1 12643.5 12765.0 19469.9 21997.3 22029.7 2230.6 2357.2 2358.4 2421.8 2738.5 9339.1 10256.4 13299.1 14354.6 14644.4 1924.0 1992.1 2029.4 2054.3 2107.3 57643.0 70630.6 72794.0 76018.2 80763.0 9703.9 9739.2 9938.9 10076.6 10179.4 13969.4 14066.4 14094.4 14140.7 14141.8 7894.0 7968.6 7968.6 8001.0 8059.3 7709.4 7797.0 7905.9 7963.9 7985.7 4451.5 4465.3 4494.3 4501.2 4508.3 1865.4 1880.0 1906.4 1915.5 1935.3 940.3 1010.0 1053.3 1077.5 1078.4 17593.7 18455.9 18700.6 18750.0 18960.4 1023.3 1036.9 1052.8 1070.2 1073.8 10122.4 10584.7 10616.9 10670.5 10741.5 466783.0 482058.0 487854.0 489594.0 490805.0 79624.0 87315.0 90039.5 90044.0 90152.0 983.4 986.4 1001.8 1005.3 1006.5 15766.4 16435.8 16522.8 16725.5 16978.9 29812.7 36378.6 36500.3 37087.6 38206.0 52657.7 54472.0 56246.4 56516.4 57026.7 7765.2 8103.7 8618.7 8638.3 8645.7 8403.0 8851.4 10669.9 12748.6 13088.3 11653.4 11792.0 12117.5 12328.4 12502.9 11509.0 11818.0 11927.5 11990.2 12353.4 5942.6 8889.5 11080.6 12079.2 12105.4 8398.5 8438.8 8454.3 8567.0 8598.0 8647.9 11821.8 11911.6 12344.6 12410.6 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#3] mootools.html Cycles:180 Average:5471.36 Median:5109.80 stddev:3073.05 (60.1%) stddev-sans-first:3065.87 20:28:09 INFO - PROCESS | 13154 | Values: 1325.2 1446.8 1498.5 1585.4 1731.5 7937.1 8271.6 8289.3 8291.7 8299.2 8042.6 8215.7 8225.0 8233.8 8246.6 2006.0 2242.3 2264.3 2303.6 2322.2 2285.5 2300.3 2300.6 2301.3 2301.6 2286.0 2289.3 2331.2 2333.9 2335.9 1952.6 2031.4 2160.4 2210.5 2228.7 2208.2 2225.0 2231.8 2235.1 2235.3 8203.9 8264.5 8271.7 8273.5 8273.5 4701.0 4846.8 4858.0 4860.5 4898.6 2982.2 3027.4 3153.2 3153.5 3194.6 950.9 951.4 957.6 988.5 993.0 11459.2 11467.9 11469.9 11503.5 11581.7 4169.2 4187.9 4296.7 4304.5 4336.4 9596.0 9624.1 9631.7 9644.7 9701.3 4926.4 4949.9 4953.6 4962.2 4965.8 4078.4 4442.3 4549.6 4558.7 4563.0 3663.9 3664.7 3737.7 3753.0 3776.3 1117.8 1175.8 1181.1 1184.7 1191.4 875.6 887.9 905.2 923.0 930.9 5733.8 5895.2 5937.7 5938.6 6148.5 933.6 965.4 972.4 996.8 1030.5 3853.8 3873.2 3980.9 4014.9 4079.4 9782.2 10126.6 10209.3 10220.5 10267.4 9898.0 10144.9 10213.5 10214.8 10239.9 7317.2 7506.6 7606.0 7613.0 7772.3 5608.5 5614.0 5660.1 5661.2 5805.6 9496.7 9556.7 9654.2 9666.0 9755.3 9152.2 9383.3 9656.6 9660.4 9744.5 6562.8 6963.7 7138.3 7157.8 7358.5 7920.2 7948.2 7982.4 8003.3 8024.5 7057.9 7265.3 7299.5 7310.8 7445.4 7231.2 7256.3 7362.4 7463.6 7531.5 6753.4 6778.5 6795.9 6803.5 6829.4 4909.4 5038.6 5060.5 5074.7 5075.9 5012.9 5093.3 5126.3 5174.0 5212.6 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#4] prototype.html Cycles:180 Average:4752.43 Median:5419.49 stddev:1442.52 (26.6%) stddev-sans-first:1407.49 20:28:09 INFO - PROCESS | 13154 | Values: 309.4 320.1 320.6 323.0 323.3 5122.5 5208.1 5296.7 5348.3 5381.9 5231.2 5235.6 5279.6 5284.7 5294.1 4119.7 4130.1 4145.0 4170.5 4179.9 3910.2 3945.9 4124.3 4144.3 4153.5 4068.0 4082.3 4084.3 4092.7 4109.4 4050.8 4079.1 4110.4 4114.3 4114.3 3546.9 3603.8 3623.5 3630.7 3641.3 5054.6 5056.9 5058.4 5071.5 5096.9 4572.2 4652.7 4659.6 4664.8 4674.3 5238.6 5415.6 5423.4 5464.5 5474.7 3918.7 3930.8 3932.6 3936.7 3946.6 5715.7 5718.2 5722.9 5740.7 5742.2 4048.8 4053.1 4065.6 4070.8 4078.1 3833.7 4016.5 4017.6 4019.4 4029.0 4606.6 4622.4 4629.4 4630.8 4632.5 5585.8 5588.2 5598.5 5599.6 5627.6 1365.2 1409.4 1445.1 1447.1 1447.8 941.2 942.2 950.0 954.3 966.5 5682.9 5684.8 5701.4 5708.5 5715.3 6041.9 6050.4 6057.9 6058.3 6062.9 5477.7 5514.5 5575.4 5597.3 5665.3 3185.4 3200.0 3204.4 3210.4 3219.2 6152.6 6236.8 6256.4 6259.2 6276.1 6157.9 6175.5 6178.2 6195.5 6205.0 6226.9 6244.1 6269.2 6269.7 6270.7 5779.2 6009.2 6023.2 6033.2 6036.2 5880.0 5920.9 5943.2 5953.6 6012.6 5996.7 6226.9 6227.7 6229.9 6247.4 4104.2 4135.1 4142.4 4142.4 4153.1 5367.5 6014.8 6028.0 6037.0 6056.5 5314.7 5553.6 5562.6 5569.6 5585.2 5529.4 5532.8 5543.6 5546.6 5551.3 5124.8 5307.4 5441.5 5443.9 5512.0 5555.5 5576.3 5583.8 5587.2 5593.7 5454.4 5467.1 5474.3 5476.8 5500.2 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - PROCESS | 13154 | [#5] yui.html Cycles:180 Average:15047.24 Median:27460.54 stddev:18245.57 (66.4%) stddev-sans-first:18264.99 20:28:09 INFO - PROCESS | 13154 | Values: 709.5 709.9 741.7 765.5 827.0 14240.9 14697.3 14702.3 15417.0 15854.0 14784.9 14860.5 14877.5 14943.3 15009.8 683.8 802.1 820.2 824.3 826.4 800.7 813.1 815.2 817.0 817.4 852.2 853.9 854.2 854.2 854.5 708.3 835.6 859.2 859.8 860.6 625.4 626.0 627.5 629.4 631.3 13624.3 13875.7 13878.7 13878.9 13903.1 13094.7 13572.0 13589.9 13671.4 13839.3 10489.4 10742.4 10752.4 11348.3 11577.5 4455.8 4463.1 4466.7 4538.9 4610.8 47025.5 47392.0 47459.0 47767.3 47805.3 9730.4 9968.3 10162.5 10493.1 10613.7 18260.5 18267.4 18300.5 18394.2 18428.8 7910.2 7919.7 8005.8 8078.4 8166.0 4840.5 4877.0 4967.6 4980.5 4992.8 3369.3 3395.4 3417.2 3441.9 3449.5 604.6 614.5 650.3 656.0 660.4 698.7 716.8 735.9 741.1 756.1 8487.5 8871.4 8956.2 9013.1 9209.4 706.0 719.9 732.7 735.2 739.7 4245.1 4312.2 4356.8 4449.8 4528.1 67826.7 70446.3 70919.3 71359.0 71361.0 56221.0 57537.0 59043.4 61099.4 62025.4 51596.7 51854.5 56978.4 57585.0 57644.7 8438.2 8637.7 8640.0 8685.7 8855.0 35391.5 36039.6 36326.1 36351.5 36925.1 46636.8 49928.3 50157.0 50159.2 50261.7 10655.2 10825.8 10853.1 10893.3 10974.3 12110.9 12305.4 12382.4 12410.5 12460.6 9405.0 11167.7 11468.8 11801.4 11926.8 11739.1 11785.9 11916.3 11978.2 12089.3 11310.3 11442.1 11471.0 11555.3 11765.6 9741.8 9921.9 10021.4 10102.2 10199.6 9584.0 9847.9 9856.8 9867.1 9892.0 20:28:09 INFO - PROCESS | 13154 | -------- Summary: end -------- 20:28:09 INFO - PROCESS | 13154 | 20:28:09 INFO - TEST-INFO | 13154: exit 0 20:28:09 INFO - TEST-OK | dromaeo_css | took 1112503ms 20:28:09 INFO - TEST-START | kraken 20:28:09 INFO - operating with platform_type : linux_ 20:28:09 INFO - Initialising browser for kraken test... 20:28:09 INFO - TEST-INFO | started process 13341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR6jI6T/profile http://localhost:54297/getInfo.html) 20:28:13 INFO - PROCESS | 13341 | __metrics Screen width/height:1600/1200 20:28:13 INFO - PROCESS | 13341 | colorDepth:24 20:28:13 INFO - PROCESS | 13341 | Browser inner width/height: 1024/697 20:28:13 INFO - PROCESS | 13341 | __metrics 20:28:14 ERROR - PROCESS | 13341 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:28:15 INFO - TEST-INFO | 13341: exit 0 20:28:15 INFO - Browser initialized. 20:28:15 INFO - Running cycle 1/1 for kraken test... 20:28:15 INFO - TEST-INFO | started process 13423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR6jI6T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:27 INFO - PROCESS | 13423 | RSS: Main: 154157056 20:28:27 INFO - PROCESS | 13423 | 20:28:30 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:30 INFO - PROCESS | 13423 | RSS: Main: 209088512 20:28:31 INFO - PROCESS | 13423 | 20:28:33 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-dft) 20:28:34 INFO - PROCESS | 13423 | RSS: Main: 195248128 20:28:34 INFO - PROCESS | 13423 | 20:28:37 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-fft) 20:28:38 INFO - PROCESS | 13423 | RSS: Main: 266031104 20:28:38 INFO - PROCESS | 13423 | 20:28:40 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-oscillator) 20:28:40 INFO - PROCESS | 13423 | RSS: Main: 174252032 20:28:40 INFO - PROCESS | 13423 | 20:28:42 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:43 INFO - PROCESS | 13423 | RSS: Main: 178819072 20:28:43 INFO - PROCESS | 13423 | 20:28:46 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:47 INFO - PROCESS | 13423 | RSS: Main: 214597632 20:28:47 INFO - PROCESS | 13423 | 20:28:50 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:51 INFO - PROCESS | 13423 | RSS: Main: 214945792 20:28:51 INFO - PROCESS | 13423 | 20:28:53 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54297/tests/kraken/driver.html?testName=json-parse-financial) 20:28:54 INFO - PROCESS | 13423 | RSS: Main: 215797760 20:28:54 INFO - PROCESS | 13423 | 20:28:56 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:56 INFO - PROCESS | 13423 | RSS: Main: 203468800 20:28:56 INFO - PROCESS | 13423 | 20:28:58 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:59 INFO - PROCESS | 13423 | RSS: Main: 207192064 20:28:59 INFO - PROCESS | 13423 | 20:29:00 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:01 INFO - PROCESS | 13423 | RSS: Main: 216141824 20:29:01 INFO - PROCESS | 13423 | 20:29:04 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:04 INFO - PROCESS | 13423 | RSS: Main: 224210944 20:29:04 INFO - PROCESS | 13423 | 20:29:07 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:08 INFO - PROCESS | 13423 | RSS: Main: 219869184 20:29:08 INFO - PROCESS | 13423 | 20:29:09 INFO - PROCESS | 13423 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54297/tests/kraken/driver.html?testName=ai-astar) 20:29:10 INFO - PROCESS | 13423 | RSS: Main: 282828800 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | __start_tp_report 20:29:10 INFO - PROCESS | 13423 | _x_x_mozilla_page_load 20:29:10 INFO - PROCESS | 13423 | _x_x_mozilla_page_load_details 20:29:10 INFO - PROCESS | 13423 | |i|pagename|runs| 20:29:10 INFO - PROCESS | 13423 | |0;ai-astar;112;114;108;111;113;113;105;113;114;111 20:29:10 INFO - PROCESS | 13423 | |1;audio-beat-detection;153;129;161;179;130;160;166;135;191;132 20:29:10 INFO - PROCESS | 13423 | |2;audio-dft;160;161;161;162;161;162;162;162;161;162 20:29:10 INFO - PROCESS | 13423 | |3;audio-fft;72;76;131;125;76;72;73;110;109;77 20:29:10 INFO - PROCESS | 13423 | |4;audio-oscillator;91;93;156;92;92;95;148;92;92;144 20:29:10 INFO - PROCESS | 13423 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;116;117;117 20:29:10 INFO - PROCESS | 13423 | |6;imaging-darkroom;146;145;147;145;145;144;146;145;145;146 20:29:10 INFO - PROCESS | 13423 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 20:29:10 INFO - PROCESS | 13423 | |8;json-parse-financial;61;61;61;60;68;61;62;80;60;59 20:29:10 INFO - PROCESS | 13423 | |9;json-stringify-tinderbox;61;61;61;61;61;61;62;62;62;61 20:29:10 INFO - PROCESS | 13423 | |10;stanford-crypto-aes;76;75;76;77;76;76;77;76;85;76 20:29:10 INFO - PROCESS | 13423 | |11;stanford-crypto-ccm;134;123;124;125;122;122;123;124;159;125 20:29:10 INFO - PROCESS | 13423 | |12;stanford-crypto-pbkdf2;171;173;173;174;177;171;172;170;170;168 20:29:10 INFO - PROCESS | 13423 | |13;stanford-crypto-sha256-iterative;72;70;69;70;69;69;72;69;68;67 20:29:10 INFO - PROCESS | 13423 | __end_tp_report 20:29:10 INFO - PROCESS | 13423 | __start_cc_report 20:29:10 INFO - PROCESS | 13423 | _x_x_mozilla_cycle_collect,1633 20:29:10 INFO - PROCESS | 13423 | __end_cc_report 20:29:10 INFO - PROCESS | 13423 | __startTimestamp1461900550237__endTimestamp 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | ------- Summary: start ------- 20:29:10 INFO - PROCESS | 13423 | Number of tests: 14 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:2.88 (2.5%) stddev-sans-first:3.04 20:29:10 INFO - PROCESS | 13423 | Values: 112.0 114.0 108.0 111.0 113.0 113.0 105.0 113.0 114.0 111.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:160.50 stddev:21.78 (13.6%) stddev-sans-first:23.10 20:29:10 INFO - PROCESS | 13423 | Values: 153.0 129.0 161.0 179.0 130.0 160.0 166.0 135.0 191.0 132.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 20:29:10 INFO - PROCESS | 13423 | Values: 160.0 161.0 161.0 162.0 161.0 162.0 162.0 162.0 161.0 162.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#3] audio-fft Cycles:10 Average:92.10 Median:72.50 stddev:23.85 (32.9%) stddev-sans-first:24.17 20:29:10 INFO - PROCESS | 13423 | Values: 72.0 76.0 131.0 125.0 76.0 72.0 73.0 110.0 109.0 77.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.66 (30.1%) stddev-sans-first:28.51 20:29:10 INFO - PROCESS | 13423 | Values: 91.0 93.0 156.0 92.0 92.0 95.0 148.0 92.0 92.0 144.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:29:10 INFO - PROCESS | 13423 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 116.0 117.0 117.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 20:29:10 INFO - PROCESS | 13423 | Values: 146.0 145.0 147.0 145.0 145.0 144.0 146.0 145.0 145.0 146.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:29:10 INFO - PROCESS | 13423 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:61.00 stddev:6.36 (10.4%) stddev-sans-first:6.69 20:29:10 INFO - PROCESS | 13423 | Values: 61.0 61.0 61.0 60.0 68.0 61.0 62.0 80.0 60.0 59.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 20:29:10 INFO - PROCESS | 13423 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.87 (3.8%) stddev-sans-first:3.02 20:29:10 INFO - PROCESS | 13423 | Values: 76.0 75.0 76.0 77.0 76.0 76.0 77.0 76.0 85.0 76.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:124.50 stddev:11.40 (9.2%) stddev-sans-first:11.89 20:29:10 INFO - PROCESS | 13423 | Values: 134.0 123.0 124.0 125.0 122.0 122.0 123.0 124.0 159.0 125.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.50 stddev:2.51 (1.5%) stddev-sans-first:2.65 20:29:10 INFO - PROCESS | 13423 | Values: 171.0 173.0 173.0 174.0 177.0 171.0 172.0 170.0 170.0 168.0 20:29:10 INFO - PROCESS | 13423 | 20:29:10 INFO - PROCESS | 13423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.39 20:29:10 INFO - PROCESS | 13423 | Values: 72.0 70.0 69.0 70.0 69.0 69.0 72.0 69.0 68.0 67.0 20:29:10 INFO - PROCESS | 13423 | -------- Summary: end -------- 20:29:10 INFO - PROCESS | 13423 | 20:29:11 INFO - TEST-INFO | 13423: exit 0 20:29:11 INFO - TEST-OK | kraken | took 61553ms 20:29:11 INFO - SUITE-END | took 1174s 20:29:11 INFO - Completed test suite (00:19:34) 20:29:11 INFO - javascript benchmark 20:29:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.6739042400545, 3152.4325621388143, 3185.092248709117, 3187.888423905162, 3213.887513937012, 5160.664556803805, 5258.13240815266, 5264.842054738359, 5300.178472336789, 5406.135018397053, 5226.738663066841, 5313.946860531393, 5361.437049109846, 5368.033753924302, 5369.838904832861, 4704.38842950416, 4769.928451073237, 4887.853364399074, 4925.359703238574, 4963.72699501529, 4868.637519318008, 4885.364902562662, 4900.387451568554, 4921.138800709879, 4924.975375123119, 4689.132510485571, 4748.97625511872, 4761.952380476203, 4767.165745994437, 4771.427428708577, 4740.786664600101, 4817.0, 4883.609311255091, 4898.191798353268, 4906.435759887623, 4720.811167553328, 4723.385959825235, 4752.7623618818925, 4769.070031343889, 4798.568128868384, 5139.460356662571, 5143.5113664201845, 5143.8456846294675, 5161.612879034087, 5188.6367954243215, 5335.733213339357, 5548.195511650828, 5581.0, 5623.325200975868, 5648.209250704905, 5556.972215138939, 5589.888202235932, 5595.18869763882, 5608.327000759894, 5622.887542249132, 5117.8720531987, 5212.843614691566, 5216.0, 5226.608004399647, 5229.816956406507, 5756.107803290497, 5814.476697097197, 5815.069588865846, 5870.236869207061, 5892.234009578728, 5440.238366628675, 5445.754941027663, 5453.863653408617, 5455.754491047833, 5457.426970168075, 5435.0488664483555, 5486.396496385394, 5524.723763811793, 5533.08704063833, 5534.05920993424, 5572.0, 5575.581831362664, 5577.498025177753, 5617.691026993554, 5626.1842032905, 5571.303587051619, 5575.721213939287, 5576.358718747315, 5577.079781836032, 5584.329880414376, 4229.915401691949, 4240.38514415408, 4281.957180428218, 4300.053988122608, 4338.76136812472, 3775.811209439572, 3778.3954567269657, 3779.905502362463, 3810.48558444612, 3815.294170578452, 5238.92141617876, 5261.631685782035, 5264.341957255343, 5266.0257852297445, 5267.604929630293, 5453.863653408696, 5609.747561359749, 5667.971660141673, 5733.598648094677, 5740.483356497935, 5165.302684137669, 5193.039287731782, 5202.661826981234, 5206.140986737221, 5212.739363031833, 4703.7883295251795, 4735.739534325645, 4735.786889589976, 4737.692050016738, 4771.427428708508, 5712.6286791358425, 5745.052066408995, 5753.280839895013, 5800.419958004166, 5804.390538993429, 5683.801066962719, 5722.341930678025, 5724.227229323988, 5726.656400615976, 5737.426257374229, 5752.9712351437975, 5795.072788353843, 5861.0, 5890.175375447355, 5901.970490147522, 5522.0, 5534.501894829485, 5536.7231638418725, 5559.499645031967, 5584.162375643686, 5604.551635869202, 5605.439456054362, 5606.943930560806, 5607.495325420732, 5630.4369563043365, 5353.170258609922, 5488.396276409512, 5536.889262214652, 5549.611527193058, 5591.9720401397735, 5453.945460545502, 5460.26286451324, 5464.0, 5467.753951072132, 5494.697791621339, 5345.839624811262, 5365.490278423544, 5378.327709036371, 5382.219578161223, 5426.0, 5347.358317001985, 5489.64317319373, 5526.91709624364, 5615.0, 5637.041702910433, 5226.398964119023, 5359.115745902039, 5380.9730951346555, 5382.058139825594, 5436.429174936575], "value": 5173.007567566414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.7991702903984, 618.4248648756657, 621.1614320667097, 625.4996003197441, 632.8069938668707, 30173.0, 30564.847175764116, 30680.84659576699, 30688.23279418013, 30700.0, 38084.80957595215, 39555.802220988924, 39634.8018259909, 39639.60360396395, 39667.801660991725, 8570.65717371306, 8882.86675699865, 8906.02033776284, 8915.643374265022, 8917.643294268222, 8679.21887030167, 8840.823183536326, 8854.822903541924, 8858.911410885874, 8859.468431894074, 8825.426347287406, 8867.600957956874, 8886.688965886195, 8894.555272236395, 8895.199432051115, 8781.912180878206, 8828.911710882938, 8843.336749743763, 8844.778880528007, 8852.159044890725, 8839.29285657146, 8953.686620968236, 8955.596998135099, 8956.104389561056, 8963.0, 40537.189256215, 41061.38407923884, 41119.383209251886, 41182.0, 41190.588094118975, 3428.7428442866635, 3580.982095089534, 3769.246150769857, 3938.5425117235955, 4235.1529694061, 31334.0, 31543.36913261745, 31826.522602160985, 32235.677643223502, 32518.349633007445, 4250.468691413574, 4365.738055716635, 4381.605655491021, 4390.824367025315, 4404.603585677304, 320835.0, 321027.0, 321431.0, 321432.9999999977, 321556.0, 44488.77755611266, 50205.0, 55452.44547554554, 55626.0, 55783.72108139433, 52563.73718131462, 52814.0, 52836.47163528315, 52845.0, 52975.47024529782, 15914.76127858083, 16162.191890405433, 16164.0, 16177.272022759003, 16180.19099045043, 11727.0, 12788.808167877489, 13021.0, 13061.673458163432, 13122.737545249041, 15885.523434296989, 16002.439914603166, 16048.117353545433, 16076.0, 16088.839111608968, 6365.267994180728, 6520.902186467207, 6534.640594767334, 6600.059946048595, 6630.336966303331, 1008.5713571731984, 1061.474570087796, 1077.8652668416448, 1114.0753174864842, 1148.782849101226, 32282.83858580692, 32820.83589582037, 32855.0, 32900.0, 33376.49935250973, 1124.5951457475303, 1136.4261048170622, 1160.3154139057997, 1186.685528334992, 1282.1153404151105, 17151.0, 17309.7403538947, 17362.739558906625, 17481.650366992588, 17584.362345647998, 470027.0, 474885.0, 476340.0, 476643.0, 479435.0, 56703.71648141815, 57121.0, 57401.0, 57509.424905750406, 57535.42464575385, 1393.1989106263939, 1395.6092294157652, 1398.8461269260374, 1428.2358937968345, 1511.508759653117, 28173.154805355873, 29139.854300728362, 31477.0, 31779.841100794347, 32040.67959320377, 39985.2002959945, 40869.0, 40978.59021409748, 41090.79454602708, 41107.0, 282620.0, 287485.0, 288245.0, 288982.0, 289830.0, 31346.686533134376, 35365.646343537264, 36918.44622330721, 36924.81537592402, 37017.62982370142, 40628.59371406248, 42351.57648423476, 44559.777201113786, 45341.69253920872, 46543.53456465392, 37456.81271593625, 37646.0, 38322.0, 38755.80622096984, 39953.2009359817, 38039.429408559445, 38163.0, 38209.80895095507, 38340.424893627176, 38674.6132538671, 36101.81949090238, 37052.25895482129, 37091.629083708816, 37146.07134821543, 39677.404838926865, 32781.83609081939, 34100.0, 34126.65873341235, 34203.0, 34462.0, 24691.135810247273, 25628.871855640602, 27160.456790864468, 27193.45613087767, 27194.0], "value": 19093.521289152857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1320137281507, 374.4439507331612, 376.1442717816966, 380.5338460386029, 383.98464061437545, 17841.28634854606, 18014.0, 18827.811721882776, 19050.618987620255, 19055.42833714987, 11273.492692828822, 11346.60286889959, 11555.826662600046, 11706.414679266045, 11715.472803723831, 4672.345871577982, 5744.368119506872, 5745.0, 5746.051901436258, 5750.884982300351, 5477.945220547784, 5544.279243698314, 5681.977244096061, 5719.770249396379, 5722.084466485363, 5625.099984002561, 5660.716964151797, 5682.488576028157, 5685.374608793029, 5685.715714214272, 5161.148410512261, 5378.327709036371, 5647.181158731982, 5648.322201335845, 5652.208690783294, 4870.975645121752, 4994.2508623706735, 5027.245913113025, 5047.64666473347, 5049.141645920203, 12643.49426022958, 12765.0, 19469.902650486798, 21997.340079797632, 22029.66955495669, 2230.5984922713906, 2357.210334537932, 2358.3526227874845, 2421.769931856471, 2738.5070687276284, 9339.112784285482, 10256.38461692301, 13299.069065165442, 14354.569362919128, 14644.41422343105, 1923.9923833703592, 1992.1334219614514, 2029.4317591074523, 2054.281001649426, 2107.2787382257247, 57643.0, 70630.64684676596, 72794.0, 76018.23981760167, 80763.0, 9703.854442183372, 9739.172170365457, 9938.850917236246, 10076.596936122472, 10179.389236645677, 13969.371378288002, 14066.43734250639, 14094.436222550983, 14140.717185656435, 14141.787873181911, 7893.960530197427, 7968.641411136513, 7968.641411136513, 8001.0, 8059.314958228499, 7709.42179336552, 7796.961015195001, 7905.920940790634, 7963.920360796434, 7985.720499782596, 4451.5325890781005, 4465.330200469955, 4494.348319493655, 4501.234790085693, 4508.278675411918, 1865.3564520240495, 1879.9530011749541, 1906.428071578521, 1915.4923945154544, 1935.2645994521993, 940.3370623710268, 1009.9848502272472, 1053.320608207717, 1077.5312738958578, 1078.44460103047, 17593.7360939586, 18455.90772046158, 18700.625987480173, 18750.0, 18960.43118706441, 1023.2785885950387, 1036.9066783989476, 1052.768390953989, 1070.2454769387564, 1073.75303680154, 10122.443265620313, 10584.682459526226, 10616.946915265375, 10670.46647667629, 10741.51663175159, 466783.0, 482058.0, 487854.0, 489594.0, 490805.0, 79624.0, 87315.0, 90039.54980225056, 90044.0, 90152.0, 983.4345251480428, 986.4475893499663, 1001.8447140693204, 1005.2711783956573, 1006.5189308354941, 15766.448174313844, 16435.753463697816, 16522.83477165213, 16725.49823505248, 16978.915105424392, 29812.701872980993, 36378.636213637525, 36500.269994599425, 37087.629123708415, 38206.044848877886, 52657.736711316196, 54472.0, 56246.43753562576, 56516.43483565276, 57026.714866425405, 7765.1846556110795, 8103.716369927024, 8618.698345557876, 8638.26574741154, 8645.654173832976, 8403.0, 8851.424657397249, 10669.879662635622, 12748.553800616934, 13088.28014459214, 11653.41732913368, 11792.0, 12117.454714537691, 12328.383580821102, 12502.87497125017, 11509.0, 11818.0, 11927.46326415296, 11990.220635658654, 12353.38233088324, 5942.584019118794, 8889.4666320021, 11080.5567777288, 12079.154459188125, 12105.394730263628, 8398.538080405637, 8438.789030274047, 8454.32365410778, 8566.957165214135, 8598.0, 8647.919010123735, 11821.822672659744, 11911.583094591648, 12344.567940122053, 12410.5656302029], "value": 8753.229926940461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.2181213084277, 1446.7974483572298, 1498.5204734484962, 1585.3500064973364, 1731.5324862287175, 7937.08723496798, 8271.586420678957, 8289.253967142957, 8291.709790157345, 8299.211574900382, 8042.597870106486, 8215.671373145082, 8225.012998440181, 8233.794155146124, 8246.628901699423, 2005.979940200594, 2242.338510139513, 2264.3320220534943, 2303.6429353450244, 2322.1640209524558, 2285.542891421714, 2300.321405185466, 2300.5858945389823, 2301.2520930697506, 2301.631738921773, 2285.9771402286015, 2289.267434420986, 2331.1957374705785, 2333.88330583471, 2335.94160145996, 1952.5899561092187, 2031.3804289691639, 2160.3518944316643, 2210.4694873230387, 2228.687983682286, 2208.2491952736145, 2224.9777502225093, 2231.787980141884, 2235.0501037059184, 2235.2847088931385, 8203.917960820376, 8264.545450000247, 8271.710490132817, 8273.46222495536, 8273.544955027472, 4701.0, 4846.75766211688, 4857.951420485785, 4860.538248866387, 4898.632602554787, 2982.239528920133, 3027.3945210957677, 3153.180173154973, 3153.5112057631104, 3194.5847039884666, 950.9144177024032, 951.3831303285632, 957.5834511987308, 988.5353883674661, 992.9751756206081, 11459.19785614999, 11467.942660286646, 11469.88530114705, 11503.482343294572, 11581.652550423416, 4169.1661667666585, 4187.937180942288, 4296.656267498593, 4304.461942257218, 4336.436263285753, 9595.952020239854, 9624.133827955518, 9631.662891798753, 9644.662436814679, 9701.320907536547, 4926.359573255526, 4949.90100197994, 4953.6037117030555, 4962.181240095416, 4965.751712414365, 4078.4494093297617, 4442.289233722653, 4549.6360291176625, 4558.680892337505, 4562.9771851141195, 3663.8900832975055, 3664.706823454117, 3737.682297004785, 3752.981235093807, 3776.263628592453, 1117.8379135025375, 1175.7589694112858, 1181.0945075115312, 1184.6682928779956, 1191.3745283725939, 875.6191056890273, 887.8978917424579, 905.2169873059756, 923.007766650853, 930.8882934047957, 5733.799317023968, 5895.233619629506, 5937.732802023919, 5938.61399009063, 6148.477379422709, 933.6265493802398, 965.3773316211004, 972.3582435592475, 996.8155891160159, 1030.5362586835954, 3853.7880416576795, 3873.24471728016, 3980.8805735827973, 4014.9397759033636, 4079.408485769606, 9782.168515676105, 10126.645567405252, 10209.285350025575, 10220.488975551192, 10267.435291058913, 9897.950510247547, 10144.949275253577, 10213.489325533694, 10214.795704085876, 10239.948800255952, 7317.195108538057, 7506.587137707369, 7605.961970190114, 7612.961935190288, 7772.300492955661, 5608.495235428831, 5614.0, 5660.122680984454, 5661.207430959586, 5805.622634528742, 9496.667616633385, 9556.665516706882, 9654.227661787181, 9666.0, 9755.268354873271, 9152.17630413266, 9383.34316597859, 9656.565454554702, 9660.420374777535, 9744.512774361112, 6562.77030303937, 6963.7214511421, 7138.321859423347, 7157.821054473679, 7358.484906056525, 7920.168382320004, 7948.244916732901, 7982.401319901147, 8003.31971782405, 8024.478408903403, 7057.858842823218, 7265.273472652904, 7299.489035767658, 7310.817229569303, 7445.4043676506835, 7231.204567497466, 7256.346928776436, 7362.3741981932135, 7463.626818659154, 7531.510451820614, 6753.3921947025, 6778.491613129134, 6795.898061528982, 6803.489738269748, 6829.351211634887, 4909.361782968192, 5038.622103342191, 5060.468650791614, 5074.746262686925, 5075.949240507695, 5012.949870501248, 5093.286939828353, 5126.307948426915, 5174.0, 5212.582993360598], "value": 4392.281166453216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.41983780411726, 320.0526441732472, 320.55122828040726, 323.04379038047387, 323.2613478202308, 5122.513361230677, 5208.114620514512, 5296.682199068054, 5348.304720386354, 5381.919271210935, 5231.189165679316, 5235.58115350772, 5279.604029697769, 5284.735763211834, 5294.094126114605, 4119.691023173259, 4130.13267213884, 4144.979275103636, 4170.499540055198, 4179.9373009404735, 3910.1984093260958, 3945.881623551298, 4124.319487284594, 4144.316187829005, 4153.480814898137, 4067.9796601016956, 4082.326416141348, 4084.2852500812387, 4092.7339722918064, 4109.445224894631, 4050.8177132029127, 4079.1433798902267, 4110.424540564323, 4114.280000999828, 4114.341705327163, 3546.8758593449365, 3603.783772973604, 3623.5289412376487, 3630.6550877666577, 3641.289948460051, 5054.620903432257, 5056.949430505685, 5058.392992840846, 5071.54356107952, 5096.898062038738, 4572.177008138534, 4652.674312798105, 4659.5573420525, 4664.836730714409, 4674.275487299474, 5238.633295669305, 5415.593830462692, 5423.376311724162, 5464.502718260277, 5474.671519708831, 3918.6865050796155, 3930.8231129599235, 3932.6264004919485, 3936.704747143947, 3946.605339466059, 5715.685637289947, 5718.227349521661, 5722.914156287659, 5740.737037851666, 5742.167385729088, 4048.817803198804, 4053.0880551875593, 4065.6380112662, 4070.8371665133654, 4078.0620457294394, 3833.6933045356304, 4016.49793775778, 4017.6183262590007, 4019.3769965654787, 4028.959710402917, 4606.608438282784, 4622.405270181782, 4629.421322334708, 4630.768461576908, 4632.490426053131, 5585.843998141037, 5588.21764952907, 5598.496135347838, 5599.60802743804, 5627.634203776742, 1365.208179256029, 1409.3587417724912, 1445.075151902762, 1447.073872721459, 1447.8127935093123, 941.1623654947102, 942.2179590939504, 949.9572519236513, 954.3224310739314, 966.4974213408988, 5682.886342273131, 5684.8294551163535, 5701.40135285789, 5708.514776243983, 5715.31416230055, 6041.879162416815, 6050.3949605040025, 6057.9403002978315, 6058.303295121029, 6062.878742425215, 5477.67133971963, 5514.531264842453, 5575.4424557543925, 5597.328320601554, 5665.2635157430095, 3185.3629274145264, 3200.0, 3204.3591281743743, 3210.4381733196597, 3219.197249540265, 6152.630842149485, 6236.812895613139, 6256.436920677161, 6259.2488901332135, 6276.121343011982, 6157.907631385443, 6175.536834737412, 6178.219801089528, 6195.504359651217, 6204.968975155095, 6226.937730622726, 6244.12582238487, 6269.153664255267, 6269.68651567429, 6270.717817698214, 5779.162021506942, 6009.2188015557695, 6023.1567580537885, 6033.215681961317, 6036.245469316335, 5880.029795083934, 5920.851978700567, 5943.197668314722, 5953.553483488669, 6012.609180403259, 5996.730147143477, 6226.875462490634, 6227.699319360746, 6229.937700622936, 6247.375262473716, 4104.220198162339, 4135.110951145518, 4142.378643203544, 4142.399352093869, 4153.086321009373, 5367.497100811779, 6014.759409623566, 6027.9806264901745, 6037.0, 6056.485198758155, 5314.654547454403, 5553.555715542666, 5562.582806289625, 5569.582281328998, 5585.162225666182, 5529.364123125892, 5532.75102620375, 5543.584231182596, 5546.611737178358, 5551.333839939233, 5124.769385377593, 5307.389650190277, 5441.5102640762525, 5443.891122177455, 5511.972440137934, 5555.472230138131, 5576.275084239023, 5583.804566840141, 5587.217789509391, 5593.692346920959, 5454.372747134131, 5467.125259958388, 5474.288342515607, 5476.7535460903555, 5500.202470641814], "value": 4289.631045964701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.4643544124186, 709.8651256261312, 741.6884908338498, 765.4527013185572, 826.9958650206748, 14240.928795356022, 14697.26513674316, 14702.264886755673, 15417.0, 15854.048757074585, 14784.926075369634, 14860.47988320409, 14877.479288224915, 14943.327550260237, 15009.774853377181, 683.7777722240266, 802.1016461563057, 820.216693058128, 824.2952275804191, 826.4421515477059, 800.6997375984006, 813.1218284252992, 815.213319147023, 816.9714060007901, 817.358373676664, 852.2457625001856, 853.871919212117, 854.218390172991, 854.2439940652537, 854.4616891358436, 708.348319546019, 835.6072645856468, 859.1837754133567, 859.8065435277075, 860.5568132411751, 625.3808729357949, 625.9843503912393, 627.5356236385088, 629.3706293706293, 631.28664608992, 13624.250666213453, 13875.653108672263, 13878.653033674138, 13878.930605346908, 13903.096298740651, 13094.672633184151, 13572.0, 13589.932050339783, 13671.384787684578, 13839.308034598229, 10489.423081730502, 10742.355458672504, 10752.354858708424, 11348.262362946381, 11577.479013444416, 4455.777211139462, 4463.107378524276, 4466.70966387187, 4538.931916021263, 4610.769461526944, 47025.5297447028, 47392.0, 47459.0, 47767.28349074732, 47805.28292075587, 9730.36752611078, 9968.252381071448, 10162.4918754062, 10493.108085812639, 10613.681589552325, 18260.543486412946, 18267.36064237772, 18300.450986470427, 18394.17226224823, 18428.815711842977, 7910.2089791020435, 7919.6832126715435, 8005.799855003672, 8078.35373170145, 8166.0, 4840.467548569725, 4876.975615121902, 4967.5777558907175, 4980.526849949249, 4992.825251116194, 3369.3261347730554, 3395.3888300105723, 3417.179876829543, 3441.8623255069515, 3449.5170676105367, 604.6341963112342, 614.529884638252, 650.2846868444673, 656.0389030070969, 660.3561527510639, 698.7135274537517, 716.8100453379858, 735.8565079809492, 741.0921621014214, 756.0964647246598, 8487.533185674723, 8871.373553282527, 8956.238719708768, 9013.098690131066, 9209.401388909699, 705.9682314295869, 719.8776208044645, 732.7105793211651, 735.1582438108443, 739.6893304811991, 4245.087306229114, 4312.180685669713, 4356.847510337123, 4449.777511124431, 4528.0943811237885, 67826.66086669535, 70446.29553704397, 70919.2908070923, 71359.0, 71361.0, 56221.0, 57537.0, 59043.40956590465, 61099.38900610937, 62025.37974620196, 51596.74201628968, 51854.48145518496, 56978.43021569814, 57585.0, 57644.71177644169, 8438.240558349778, 8637.740867773977, 8640.0, 8685.696000639948, 8855.0, 35391.46912796362, 36039.63960360468, 36326.09184770402, 36351.45472817857, 36925.07687307839, 46636.7668161657, 49928.25107623316, 50157.0, 50159.24761128513, 50261.74869125631, 10655.200859935381, 10825.783484330426, 10853.077488413574, 10893.291936024134, 10974.341539507655, 12110.878891210976, 12305.384730763248, 12382.442790074649, 12410.503579856704, 12460.626181214579, 9404.95297523508, 11167.664970050912, 11468.827967580326, 11801.409929503663, 11926.821097683369, 11739.11956603241, 11785.88214117848, 11916.285022898654, 11978.221415607957, 12089.274643521418, 11310.321380716854, 11442.084633229155, 11471.0, 11555.306681599131, 11765.588204412805, 9741.80516389654, 9921.851172232567, 10021.39871607706, 10102.191824653863, 10199.643012494527, 9583.952080239555, 9847.901520984986, 9856.753581160528, 9867.111959923353, 9892.0], "value": 6683.605880229837, "unit": "score"}], "name": "dromaeo_css", "value": 6910.250376481064, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 108.0, 111.0, 113.0, 113.0, 105.0, 113.0, 114.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 161.0, 179.0, 130.0, 160.0, 166.0, 135.0, 191.0, 132.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 131.0, 125.0, 76.0, 72.0, 73.0, 110.0, 109.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 156.0, 92.0, 92.0, 95.0, 148.0, 92.0, 92.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 68.0, 61.0, 62.0, 80.0, 60.0, 59.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 77.0, 76.0, 76.0, 77.0, 76.0, 85.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 123.0, 124.0, 125.0, 122.0, 122.0, 123.0, 124.0, 159.0, 125.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 173.0, 174.0, 177.0, 171.0, 172.0, 170.0, 170.0, 168.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 70.0, 69.0, 69.0, 72.0, 69.0, 68.0, 67.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1556.5, "alertThreshold": 2.0}]} 20:29:11 INFO - Return code: 0 20:29:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:11 ERROR - # TBPL SUCCESS # 20:29:11 INFO - Running post-action listener: _resource_record_post_action 20:29:11 INFO - Running post-run listener: _resource_record_post_run 20:29:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546594816; Read time: 16; Write time: 599608 20:29:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257069056; Read time: 0; Write time: 293900 20:29:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289525760; Read time: 16; Write time: 305708 20:29:12 INFO - Running post-run listener: _upload_blobber_files 20:29:12 INFO - Blob upload gear active. 20:29:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:12 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 20:29:12 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'] 20:29:12 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 20:29:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:14 INFO - (blobuploader) - INFO - Done attempting. 20:29:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:14 INFO - (blobuploader) - INFO - Done attempting. 20:29:14 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:14 INFO - Return code: 0 20:29:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e36e710526a52ba0f47c5f948ef8a6e65f42ea85815e7e6241527db79bd650ff2aaaf0c2b7e6525290179bdb7dcc1e4020a769c1d330b3317f471c01f4be2f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acea769dd915eece0e3531a48150ae5a94668a3fd1cc5f2e0507e97a4e23c6562e22914e3b7166bb29b8e756e7c47e2d490365d30871d146f57532d27302fc1"} 20:29:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:14 INFO - Contents: 20:29:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e36e710526a52ba0f47c5f948ef8a6e65f42ea85815e7e6241527db79bd650ff2aaaf0c2b7e6525290179bdb7dcc1e4020a769c1d330b3317f471c01f4be2f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acea769dd915eece0e3531a48150ae5a94668a3fd1cc5f2e0507e97a4e23c6562e22914e3b7166bb29b8e756e7c47e2d490365d30871d146f57532d27302fc1"} 20:29:14 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:14 INFO - Copying logs to upload dir... 20:29:14 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.256095 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 20:29:14.400173) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 20:29:14.404224) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 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/e36e710526a52ba0f47c5f948ef8a6e65f42ea85815e7e6241527db79bd650ff2aaaf0c2b7e6525290179bdb7dcc1e4020a769c1d330b3317f471c01f4be2f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acea769dd915eece0e3531a48150ae5a94668a3fd1cc5f2e0507e97a4e23c6562e22914e3b7166bb29b8e756e7c47e2d490365d30871d146f57532d27302fc1"} build_url:https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/HteF7er7SPmEGvUKUEz7Kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e36e710526a52ba0f47c5f948ef8a6e65f42ea85815e7e6241527db79bd650ff2aaaf0c2b7e6525290179bdb7dcc1e4020a769c1d330b3317f471c01f4be2f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acea769dd915eece0e3531a48150ae5a94668a3fd1cc5f2e0507e97a4e23c6562e22914e3b7166bb29b8e756e7c47e2d490365d30871d146f57532d27302fc1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 20:29:14.429327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:29:14.429671) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461897357.609446-316556583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 20:29:14.514651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 20:29:14.515010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 20:29:14.515345) ========= ========= Total master_lag: 0.18 =========