builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1464718952.8 results: success (0) buildid: 20160531083039 builduid: 19c396da657846dbb4511b8174a8e739 revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:32.798632) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:32.799191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:32.799505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:32.868583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:32.869097) ========= 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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 11:22:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2016-05-31 11:22:33 (105 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133385 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:33.036687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:33.037222) ========= 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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019364 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:33.090405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-31 11:22:33.090734) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6617e62776cdf01627f146087690cfc7c883508a --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 6617e62776cdf01627f146087690cfc7c883508a --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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 11:22:33,142 truncating revision to first 12 chars 2016-05-31 11:22:33,142 Setting DEBUG logging. 2016-05-31 11:22:33,143 attempt 1/10 2016-05-31 11:22:33,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6617e62776cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 11:22:36,463 unpacking tar archive at: fx-team-6617e62776cd/testing/mozharness/ program finished with exit code 0 elapsedTime=3.669660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-31 11:22:36.773911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:36.774242) ========= script_repo_revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:36.774658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:36.774950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 11:22:36.785197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-31 11:22:36.785531) ========= /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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:36 INFO - MultiFileLogger online at 20160531 11:22:36 in /builds/slave/test 11:22:36 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 11:22:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:36 INFO - {'append_to_log': False, 11:22:36 INFO - 'base_work_dir': '/builds/slave/test', 11:22:36 INFO - 'blob_upload_branch': 'Fx-Team', 11:22:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:36 INFO - 'branch': 'Fx-Team', 11:22:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:36 INFO - 'config_files': ('talos/linux_config.py',), 11:22:36 INFO - 'default_actions': ('clobber', 11:22:36 INFO - 'read-buildbot-config', 11:22:36 INFO - 'download-and-extract', 11:22:36 INFO - 'populate-webroot', 11:22:36 INFO - 'create-virtualenv', 11:22:36 INFO - 'install', 11:22:36 INFO - 'run-tests'), 11:22:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:36 INFO - 'download_minidump_stackwalk': True, 11:22:36 INFO - 'download_symbols': 'ondemand', 11:22:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:36 INFO - 'installer_path': 'installer.exe', 11:22:36 INFO - 'log_level': 'info', 11:22:36 INFO - 'log_name': 'talos', 11:22:36 INFO - 'log_to_console': True, 11:22:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:36 INFO - 'opt_config_files': (), 11:22:36 INFO - 'pip_index': False, 11:22:36 INFO - 'sps_profile': False, 11:22:36 INFO - 'sps_profile_interval': 0, 11:22:36 INFO - 'suite': 'dromaeojs', 11:22:36 INFO - 'system_bits': '32', 11:22:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:37 INFO - 'title': 'talos-linux64-ix-053', 11:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:37 INFO - 'use_talos_json': True, 11:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:37 INFO - 'work_dir': 'build'} 11:22:37 INFO - ##### 11:22:37 INFO - ##### Running clobber step. 11:22:37 INFO - ##### 11:22:37 INFO - Running pre-action listener: _resource_record_pre_action 11:22:37 INFO - Running main action method: clobber 11:22:37 INFO - rmtree: /builds/slave/test/build 11:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:37 INFO - Running post-action listener: _resource_record_post_action 11:22:37 INFO - ##### 11:22:37 INFO - ##### Finished clobber step (success) 11:22:37 INFO - ##### 11:22:37 INFO - ##### 11:22:37 INFO - ##### Running read-buildbot-config step. 11:22:37 INFO - ##### 11:22:37 INFO - Running pre-action listener: _resource_record_pre_action 11:22:37 INFO - Running main action method: read_buildbot_config 11:22:37 INFO - Using buildbot properties: 11:22:37 INFO - { 11:22:37 INFO - "project": "", 11:22:37 INFO - "product": "firefox", 11:22:37 INFO - "script_repo_revision": "production", 11:22:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:22:37 INFO - "repository": "", 11:22:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:22:37 INFO - "buildid": "20160531083039", 11:22:37 INFO - "pgo_build": "True", 11:22:37 INFO - "basedir": "/builds/slave/test", 11:22:37 INFO - "buildnumber": 747, 11:22:37 INFO - "slavename": "talos-linux64-ix-053", 11:22:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:37 INFO - "platform": "ubuntu64_hw", 11:22:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:22:37 INFO - "branch": "fx-team", 11:22:37 INFO - "repo_path": "integration/fx-team", 11:22:37 INFO - "revision": "6617e62776cdf01627f146087690cfc7c883508a", 11:22:37 INFO - "stage_platform": "linux64-pgo", 11:22:37 INFO - "builduid": "19c396da657846dbb4511b8174a8e739", 11:22:37 INFO - "slavebuilddir": "test" 11:22:37 INFO - } 11:22:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:22:37 INFO - Running post-action listener: _resource_record_post_action 11:22:37 INFO - ##### 11:22:37 INFO - ##### Finished read-buildbot-config step (success) 11:22:37 INFO - ##### 11:22:37 INFO - ##### 11:22:37 INFO - ##### Running download-and-extract step. 11:22:37 INFO - ##### 11:22:37 INFO - Running pre-action listener: _resource_record_pre_action 11:22:37 INFO - Running main action method: download_and_extract 11:22:37 INFO - mkdir: /builds/slave/test/build/tests 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:22:37 INFO - https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:38 INFO - Downloaded 1361 bytes. 11:22:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:38 INFO - Using the following test package requirements: 11:22:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:22:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'jsshell-linux-x86_64.zip'], 11:22:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:22:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:22:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:22:38 INFO - https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:40 INFO - Downloaded 24412676 bytes. 11:22:40 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'] 11:22:40 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 11:22:41 INFO - Return code: 0 11:22:41 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 11:22:41 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')]} 11:22:41 INFO - https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:43 INFO - Downloaded 24412676 bytes. 11:22:43 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'] 11:22:43 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 11:22:44 INFO - Return code: 0 11:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:22:44 INFO - https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:46 INFO - Downloaded 10834055 bytes. 11:22:46 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'] 11:22:46 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 11:22:46 INFO - Return code: 0 11:22: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')]} 11:22:46 INFO - https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDlI9gs_TaGCbijQYCCDcw/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 11:22:48 INFO - Downloaded 58974844 bytes. 11:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:48 INFO - mkdir: /builds/slave/test/properties 11:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:48 INFO - Contents: 11:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:49 INFO - Running post-action listener: _resource_record_post_action 11:22:49 INFO - Running post-action listener: set_extra_try_arguments 11:22:49 INFO - ##### 11:22:49 INFO - ##### Finished download-and-extract step (success) 11:22:49 INFO - ##### 11:22:49 INFO - ##### 11:22:49 INFO - ##### Running populate-webroot step. 11:22:49 INFO - ##### 11:22:49 INFO - Running pre-action listener: _resource_record_pre_action 11:22:49 INFO - Running main action method: populate_webroot 11:22:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:49 INFO - '--tppagecycles', 11:22:49 INFO - '7'], 11:22:49 INFO - 'tests': ['tsvgm']}}, 11:22:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['damp', 'tps']}, 11:22:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'tests': ['damp', 'tps']}, 11:22:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['dromaeo_dom']}, 11:22:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['a11yr', 11:22:49 INFO - 'ts_paint', 11:22:49 INFO - 'tpaint', 11:22:49 INFO - 'sessionrestore', 11:22:49 INFO - 'sessionrestore_no_auto_restore', 11:22:49 INFO - 'tabpaint']}, 11:22:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['tsvgx', 11:22:49 INFO - 'tsvgr_opacity', 11:22:49 INFO - 'tart', 11:22:49 INFO - 'tscrollx', 11:22:49 INFO - 'cart']}, 11:22:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:49 INFO - 'tsvgr_opacity', 11:22:49 INFO - 'tart', 11:22:49 INFO - 'tscrollx', 11:22:49 INFO - 'cart']}, 11:22:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'talos_options': ['--disable-e10s'], 11:22:49 INFO - 'tests': ['tp5o']}, 11:22:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'tests': ['tp5o']}, 11:22:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'talos_options': ['--disable-e10s', 11:22:49 INFO - '--xperf_path', 11:22:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:49 INFO - 'tests': ['tp5n']}, 11:22:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:49 INFO - 'talos_options': ['--xperf_path', 11:22:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:49 INFO - 'tests': ['tp5n']}}, 11:22:49 INFO - 'talos.zip': {'path': '', 11:22:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:49 INFO - Running post-action listener: _resource_record_post_action 11:22:49 INFO - ##### 11:22:49 INFO - ##### Finished populate-webroot step (success) 11:22:49 INFO - ##### 11:22:49 INFO - ##### 11:22:49 INFO - ##### Running create-virtualenv step. 11:22:49 INFO - ##### 11:22:49 INFO - Running pre-action listener: _resource_record_pre_action 11:22:49 INFO - Running main action method: create_virtualenv 11:22:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:49 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 11:22:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:49 INFO - Using real prefix '/usr' 11:22:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:52 INFO - Installing pip.................done. 11:22:52 INFO - Return code: 0 11:22:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:52 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:22:52 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 11:22:52 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 11:22:52 INFO - Using env: {'DISPLAY': ':0', 11:22:52 INFO - 'HOME': '/home/cltbld', 11:22:52 INFO - 'LANG': 'en_US.UTF-8', 11:22:52 INFO - 'LANGUAGE': 'en_US:en', 11:22:52 INFO - 'LOGNAME': 'cltbld', 11:22:52 INFO - 'MAIL': '/var/mail/cltbld', 11:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:52 INFO - 'MOZ_NO_REMOTE': '1', 11:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:52 INFO - 'NO_EM_RESTART': '1', 11:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:52 INFO - 'PWD': '/builds/slave/test', 11:22:52 INFO - 'SHELL': '/bin/bash', 11:22:52 INFO - 'SHLVL': '1', 11:22:52 INFO - 'TERM': 'linux', 11:22:52 INFO - 'TMOUT': '86400', 11:22:52 INFO - 'USER': 'cltbld', 11:22:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:52 INFO - '_': '/tools/buildbot/bin/python'} 11:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:52 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 11:22:52 INFO - Cleaning up... 11:22:52 INFO - Return code: 0 11:22:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:22:52 INFO - Using env: {'DISPLAY': ':0', 11:22:52 INFO - 'HOME': '/home/cltbld', 11:22:52 INFO - 'LANG': 'en_US.UTF-8', 11:22:52 INFO - 'LANGUAGE': 'en_US:en', 11:22:52 INFO - 'LOGNAME': 'cltbld', 11:22:52 INFO - 'MAIL': '/var/mail/cltbld', 11:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:52 INFO - 'MOZ_NO_REMOTE': '1', 11:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:52 INFO - 'NO_EM_RESTART': '1', 11:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:52 INFO - 'PWD': '/builds/slave/test', 11:22:52 INFO - 'SHELL': '/bin/bash', 11:22:52 INFO - 'SHLVL': '1', 11:22:52 INFO - 'TERM': 'linux', 11:22:52 INFO - 'TMOUT': '86400', 11:22:52 INFO - 'USER': 'cltbld', 11:22:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:52 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:53 INFO - Downloading/unpacking psutil>=3.1.1 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:55 INFO - Installing collected packages: psutil 11:22:55 INFO - Running setup.py install for psutil 11:22:55 INFO - building 'psutil._psutil_linux' extension 11:22:55 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 11:22:56 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 11:22:56 INFO - building 'psutil._psutil_posix' extension 11:22:56 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 11:22:56 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 11:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:56 INFO - Successfully installed psutil 11:22:56 INFO - Cleaning up... 11:22:56 INFO - Return code: 0 11:22:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:56 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')]} 11:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 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')]} 11:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:56 INFO - Using env: {'DISPLAY': ':0', 11:22:56 INFO - 'HOME': '/home/cltbld', 11:22:56 INFO - 'LANG': 'en_US.UTF-8', 11:22:56 INFO - 'LANGUAGE': 'en_US:en', 11:22:56 INFO - 'LOGNAME': 'cltbld', 11:22:56 INFO - 'MAIL': '/var/mail/cltbld', 11:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:56 INFO - 'MOZ_NO_REMOTE': '1', 11:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:56 INFO - 'NO_EM_RESTART': '1', 11:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:56 INFO - 'PWD': '/builds/slave/test', 11:22:56 INFO - 'SHELL': '/bin/bash', 11:22:56 INFO - 'SHLVL': '1', 11:22:56 INFO - 'TERM': 'linux', 11:22:56 INFO - 'TMOUT': '86400', 11:22:56 INFO - 'USER': 'cltbld', 11:22:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:56 INFO - '_': '/tools/buildbot/bin/python'} 11:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:58 INFO - Installing collected packages: mozsystemmonitor 11:22:58 INFO - Running setup.py install for mozsystemmonitor 11:22:59 INFO - Successfully installed mozsystemmonitor 11:22:59 INFO - Cleaning up... 11:22:59 INFO - Return code: 0 11:22:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:59 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')]} 11:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:59 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')]} 11:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:59 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:22:59 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 11:22:59 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 11:22:59 INFO - Using env: {'DISPLAY': ':0', 11:22:59 INFO - 'HOME': '/home/cltbld', 11:22:59 INFO - 'LANG': 'en_US.UTF-8', 11:22:59 INFO - 'LANGUAGE': 'en_US:en', 11:22:59 INFO - 'LOGNAME': 'cltbld', 11:22:59 INFO - 'MAIL': '/var/mail/cltbld', 11:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:59 INFO - 'MOZ_NO_REMOTE': '1', 11:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:59 INFO - 'NO_EM_RESTART': '1', 11:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:59 INFO - 'PWD': '/builds/slave/test', 11:22:59 INFO - 'SHELL': '/bin/bash', 11:22:59 INFO - 'SHLVL': '1', 11:22:59 INFO - 'TERM': 'linux', 11:22:59 INFO - 'TMOUT': '86400', 11:22:59 INFO - 'USER': 'cltbld', 11:22:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:59 INFO - '_': '/tools/buildbot/bin/python'} 11:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:23:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 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 11:23:01 INFO - Downloading docopt-0.6.1.tar.gz 11:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:02 INFO - Running setup.py install for blobuploader 11:23:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:02 INFO - Running setup.py install for requests 11:23:02 INFO - Running setup.py install for docopt 11:23:02 INFO - Successfully installed blobuploader requests docopt 11:23:02 INFO - Cleaning up... 11:23:02 INFO - Return code: 0 11:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:02 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:23:02 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 11:23:02 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 11:23:02 INFO - Using env: {'DISPLAY': ':0', 11:23:02 INFO - 'HOME': '/home/cltbld', 11:23:02 INFO - 'LANG': 'en_US.UTF-8', 11:23:02 INFO - 'LANGUAGE': 'en_US:en', 11:23:02 INFO - 'LOGNAME': 'cltbld', 11:23:02 INFO - 'MAIL': '/var/mail/cltbld', 11:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:02 INFO - 'MOZ_NO_REMOTE': '1', 11:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:02 INFO - 'NO_EM_RESTART': '1', 11:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:02 INFO - 'PWD': '/builds/slave/test', 11:23:02 INFO - 'SHELL': '/bin/bash', 11:23:02 INFO - 'SHLVL': '1', 11:23:02 INFO - 'TERM': 'linux', 11:23:02 INFO - 'TMOUT': '86400', 11:23:02 INFO - 'USER': 'cltbld', 11:23:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:02 INFO - '_': '/tools/buildbot/bin/python'} 11:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:02 INFO - Running setup.py (path:/tmp/pip-BVm5Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:02 INFO - Running setup.py (path:/tmp/pip-mvmjYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:02 INFO - Running setup.py (path:/tmp/pip-g_bMgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:03 INFO - Running setup.py (path:/tmp/pip-cALjFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:03 INFO - Running setup.py (path:/tmp/pip-4Vt00i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Running setup.py (path:/tmp/pip-tzYOPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Running setup.py (path:/tmp/pip-yB7_iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Running setup.py (path:/tmp/pip-Pr9qzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:03 INFO - Running setup.py (path:/tmp/pip-mgW0Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:03 INFO - Running setup.py (path:/tmp/pip-7RoROV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:03 INFO - Running setup.py (path:/tmp/pip-tanw5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:03 INFO - Running setup.py (path:/tmp/pip-jqCUmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:03 INFO - Running setup.py (path:/tmp/pip-PFDf3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:03 INFO - Running setup.py (path:/tmp/pip-9eNaZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:03 INFO - Running setup.py (path:/tmp/pip-K3NIIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:03 INFO - Running setup.py (path:/tmp/pip-HeZ0Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:03 INFO - Running setup.py (path:/tmp/pip-6Bv0kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:04 INFO - Running setup.py install for manifestparser 11:23:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozcrash 11:23:04 INFO - Running setup.py install for mozdebug 11:23:04 INFO - Running setup.py install for mozdevice 11:23:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozfile 11:23:04 INFO - Running setup.py install for mozhttpd 11:23:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozinfo 11:23:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozInstall 11:23:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozleak 11:23:04 INFO - Running setup.py install for mozlog 11:23:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for moznetwork 11:23:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozprocess 11:23:05 INFO - Running setup.py install for mozprofile 11:23:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozrunner 11:23:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozscreenshot 11:23:05 INFO - Running setup.py install for moztest 11:23:05 INFO - Running setup.py install for mozversion 11:23:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:05 INFO - Cleaning up... 11:23:05 INFO - Return code: 0 11:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:05 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')]} 11:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:05 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')]} 11:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:05 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:23:05 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 11:23:05 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 11:23:05 INFO - Using env: {'DISPLAY': ':0', 11:23:05 INFO - 'HOME': '/home/cltbld', 11:23:05 INFO - 'LANG': 'en_US.UTF-8', 11:23:05 INFO - 'LANGUAGE': 'en_US:en', 11:23:05 INFO - 'LOGNAME': 'cltbld', 11:23:05 INFO - 'MAIL': '/var/mail/cltbld', 11:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:05 INFO - 'MOZ_NO_REMOTE': '1', 11:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:05 INFO - 'NO_EM_RESTART': '1', 11:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:05 INFO - 'PWD': '/builds/slave/test', 11:23:05 INFO - 'SHELL': '/bin/bash', 11:23:05 INFO - 'SHLVL': '1', 11:23:05 INFO - 'TERM': 'linux', 11:23:05 INFO - 'TMOUT': '86400', 11:23:05 INFO - 'USER': 'cltbld', 11:23:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:05 INFO - '_': '/tools/buildbot/bin/python'} 11:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:06 INFO - Running setup.py (path:/tmp/pip-parrkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:06 INFO - Running setup.py (path:/tmp/pip-OnHeht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:06 INFO - Running setup.py (path:/tmp/pip-XKB1ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:06 INFO - Running setup.py (path:/tmp/pip-2lh6xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:06 INFO - Running setup.py (path:/tmp/pip-7gY7Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:06 INFO - Running setup.py (path:/tmp/pip-xy8AT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:06 INFO - Running setup.py (path:/tmp/pip-k4XNjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:06 INFO - Running setup.py (path:/tmp/pip-sg3sNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:06 INFO - Running setup.py (path:/tmp/pip-CcP0cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:06 INFO - Running setup.py (path:/tmp/pip-cB5XV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:06 INFO - Running setup.py (path:/tmp/pip-WOj_jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:06 INFO - Running setup.py (path:/tmp/pip-urvGQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:06 INFO - Running setup.py (path:/tmp/pip-6UIe55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:06 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)) 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:06 INFO - Running setup.py (path:/tmp/pip-2PS5mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:07 INFO - Running setup.py (path:/tmp/pip-YHBz2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:07 INFO - Running setup.py (path:/tmp/pip-e4tcHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:07 INFO - Running setup.py (path:/tmp/pip-XuAiCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:07 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)) 11:23:07 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)) 11:23:07 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)) 11:23:07 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)) 11:23:07 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)) 11:23:07 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)) 11:23:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:07 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 11:23:07 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 11:23:07 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 11:23:07 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 11:23:07 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 11:23:07 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 11:23:09 INFO - Downloading blessings-1.6.tar.gz 11:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:09 INFO - Installing collected packages: blessings 11:23:09 INFO - Running setup.py install for blessings 11:23:09 INFO - Successfully installed blessings 11:23:09 INFO - Cleaning up... 11:23:09 INFO - Return code: 0 11:23:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:09 INFO - Reading from file tmpfile_stdout 11:23:09 INFO - Current package versions: 11:23:09 INFO - argparse == 1.2.1 11:23:09 INFO - blessings == 1.6 11:23:09 INFO - blobuploader == 1.2.4 11:23:09 INFO - docopt == 0.6.1 11:23:09 INFO - manifestparser == 1.1 11:23:09 INFO - mozInstall == 1.12 11:23:09 INFO - mozcrash == 0.17 11:23:09 INFO - mozdebug == 0.1 11:23:09 INFO - mozdevice == 0.48 11:23:09 INFO - mozfile == 1.2 11:23:09 INFO - mozhttpd == 0.7 11:23:09 INFO - mozinfo == 0.9 11:23:09 INFO - mozleak == 0.1 11:23:09 INFO - mozlog == 3.2 11:23:09 INFO - moznetwork == 0.27 11:23:09 INFO - mozprocess == 0.22 11:23:09 INFO - mozprofile == 0.28 11:23:09 INFO - mozrunner == 6.11 11:23:09 INFO - mozscreenshot == 0.1 11:23:09 INFO - mozsystemmonitor == 0.3 11:23:09 INFO - moztest == 0.7 11:23:09 INFO - mozversion == 1.4 11:23:09 INFO - psutil == 3.1.1 11:23:09 INFO - requests == 1.2.3 11:23:09 INFO - wsgiref == 0.1.2 11:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:09 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:23:09 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 11:23:09 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 11:23:09 INFO - Using env: {'DISPLAY': ':0', 11:23:09 INFO - 'HOME': '/home/cltbld', 11:23:09 INFO - 'LANG': 'en_US.UTF-8', 11:23:09 INFO - 'LANGUAGE': 'en_US:en', 11:23:09 INFO - 'LOGNAME': 'cltbld', 11:23:09 INFO - 'MAIL': '/var/mail/cltbld', 11:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:09 INFO - 'MOZ_NO_REMOTE': '1', 11:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:09 INFO - 'NO_EM_RESTART': '1', 11:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:09 INFO - 'PWD': '/builds/slave/test', 11:23:09 INFO - 'SHELL': '/bin/bash', 11:23:09 INFO - 'SHLVL': '1', 11:23:09 INFO - 'TERM': 'linux', 11:23:09 INFO - 'TMOUT': '86400', 11:23:09 INFO - 'USER': 'cltbld', 11:23:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:09 INFO - '_': '/tools/buildbot/bin/python'} 11:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 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)) 11:23:09 INFO - Cleaning up... 11:23:09 INFO - Return code: 0 11:23:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:09 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:23:09 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 11:23:09 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 11:23:09 INFO - Using env: {'DISPLAY': ':0', 11:23:09 INFO - 'HOME': '/home/cltbld', 11:23:09 INFO - 'LANG': 'en_US.UTF-8', 11:23:09 INFO - 'LANGUAGE': 'en_US:en', 11:23:09 INFO - 'LOGNAME': 'cltbld', 11:23:09 INFO - 'MAIL': '/var/mail/cltbld', 11:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:09 INFO - 'MOZ_NO_REMOTE': '1', 11:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:09 INFO - 'NO_EM_RESTART': '1', 11:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:09 INFO - 'PWD': '/builds/slave/test', 11:23:09 INFO - 'SHELL': '/bin/bash', 11:23:09 INFO - 'SHLVL': '1', 11:23:09 INFO - 'TERM': 'linux', 11:23:09 INFO - 'TMOUT': '86400', 11:23:09 INFO - 'USER': 'cltbld', 11:23:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:09 INFO - '_': '/tools/buildbot/bin/python'} 11:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:10 INFO - Downloading/unpacking jsonschema 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:23:12 INFO - Downloading/unpacking functools32 (from jsonschema) 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz 11:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:23:12 INFO - warning: no files found matching '*.txt' 11:23:12 INFO - no previously-included directories found matching 'build' 11:23:12 INFO - no previously-included directories found matching 'dist' 11:23:12 INFO - no previously-included directories found matching '.git*' 11:23:12 INFO - Installing collected packages: jsonschema, functools32 11:23:12 INFO - Running setup.py install for functools32 11:23:12 INFO - warning: no files found matching '*.txt' 11:23:12 INFO - no previously-included directories found matching 'build' 11:23:12 INFO - no previously-included directories found matching 'dist' 11:23:12 INFO - no previously-included directories found matching '.git*' 11:23:12 INFO - Successfully installed jsonschema functools32 11:23:12 INFO - Cleaning up... 11:23:12 INFO - Return code: 0 11:23:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:23:12 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')]} 11:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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')]} 11:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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 0x7f263f039f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, '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': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', '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 11:23:12 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 11:23:12 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 11:23:12 INFO - Using env: {'DISPLAY': ':0', 11:23:12 INFO - 'HOME': '/home/cltbld', 11:23:12 INFO - 'LANG': 'en_US.UTF-8', 11:23:12 INFO - 'LANGUAGE': 'en_US:en', 11:23:12 INFO - 'LOGNAME': 'cltbld', 11:23:12 INFO - 'MAIL': '/var/mail/cltbld', 11:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:12 INFO - 'MOZ_NO_REMOTE': '1', 11:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:12 INFO - 'NO_EM_RESTART': '1', 11:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:12 INFO - 'PWD': '/builds/slave/test', 11:23:12 INFO - 'SHELL': '/bin/bash', 11:23:12 INFO - 'SHLVL': '1', 11:23:12 INFO - 'TERM': 'linux', 11:23:12 INFO - 'TMOUT': '86400', 11:23:12 INFO - 'USER': 'cltbld', 11:23:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:12 INFO - '_': '/tools/buildbot/bin/python'} 11:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:12 INFO - Downloading/unpacking flake8 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:23:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:23:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:23:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:23:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:23:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:23:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:23:15 INFO - no previously-included directories found matching 'docs/_build' 11:23:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:23:15 INFO - Running setup.py install for pep8 11:23:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:23:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:23:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:23:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:23:15 INFO - no previously-included directories found matching 'docs/_build' 11:23:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:23:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:23:15 INFO - Cleaning up... 11:23:15 INFO - Return code: 0 11:23:15 INFO - Running post-action listener: _resource_record_post_action 11:23:15 INFO - Running post-action listener: _start_resource_monitoring 11:23:15 INFO - Starting resource monitoring. 11:23:15 INFO - ##### 11:23:15 INFO - ##### Finished create-virtualenv step (success) 11:23:15 INFO - ##### 11:23:15 INFO - ##### 11:23:15 INFO - ##### Running install step. 11:23:15 INFO - ##### 11:23:15 INFO - Running pre-action listener: _resource_record_pre_action 11:23:15 INFO - Running main action method: install 11:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:15 INFO - Reading from file tmpfile_stdout 11:23:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:15 INFO - Reading from file tmpfile_stdout 11:23:15 INFO - Output received: 11:23:15 INFO - Usage: mozinstall [options] installer 11:23:15 INFO - Options: 11:23:15 INFO - -h, --help show this help message and exit 11:23:15 INFO - -d DEST, --destination=DEST 11:23:15 INFO - Directory to install application into. [default: 11:23:15 INFO - "/builds/slave/test"] 11:23:15 INFO - --app=APP Application being installed. [default: firefox] 11:23:15 INFO - mkdir: /builds/slave/test/build/application 11:23:15 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'] 11:23:15 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 11:23:32 INFO - Reading from file tmpfile_stdout 11:23:32 INFO - Output received: 11:23:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:23:32 INFO - Running post-action listener: _resource_record_post_action 11:23:32 INFO - ##### 11:23:32 INFO - ##### Finished install step (success) 11:23:32 INFO - ##### 11:23:32 INFO - ##### 11:23:32 INFO - ##### Running run-tests step. 11:23:32 INFO - ##### 11:23:32 INFO - Running pre-action listener: _resource_record_pre_action 11:23:32 INFO - Running main action method: run_tests 11:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:32 INFO - Python 2.7.3 11:23:32 INFO - Return code: 0 11:23:32 INFO - grabbing minidump binary from tooltool 11:23:32 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')]} 11:23:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b11b20>, '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 0x1b12a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:32 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 11:23:32 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 11:23:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:23:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:32 INFO - Return code: 0 11:23:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:23:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:23:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:23:33 INFO - Return code: 0 11:23:33 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/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:23:33 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/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 11:23:33 INFO - Using env: {'DISPLAY': ':0', 11:23:33 INFO - 'HOME': '/home/cltbld', 11:23:33 INFO - 'LANG': 'en_US.UTF-8', 11:23:33 INFO - 'LANGUAGE': 'en_US:en', 11:23:33 INFO - 'LOGNAME': 'cltbld', 11:23:33 INFO - 'MAIL': '/var/mail/cltbld', 11:23:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:33 INFO - 'MOZ_NO_REMOTE': '1', 11:23:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:33 INFO - 'NO_EM_RESTART': '1', 11:23:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:33 INFO - 'PWD': '/builds/slave/test', 11:23:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:33 INFO - 'SHELL': '/bin/bash', 11:23:33 INFO - 'SHLVL': '1', 11:23:33 INFO - 'TERM': 'linux', 11:23:33 INFO - 'TMOUT': '86400', 11:23:33 INFO - 'USER': 'cltbld', 11:23:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934', 11:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:33 INFO - '_': '/tools/buildbot/bin/python'} 11:23:33 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/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:23:33 INFO - mozversion application_buildid: 20160531083039 11:23:33 INFO - mozversion application_changeset: 6617e62776cdf01627f146087690cfc7c883508a 11:23:33 INFO - mozversion application_display_name: Nightly 11:23:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:33 INFO - mozversion application_name: Firefox 11:23:33 INFO - mozversion application_remotingname: firefox 11:23:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:23:33 INFO - mozversion application_vendor: Mozilla 11:23:33 INFO - mozversion application_version: 49.0a1 11:23:33 INFO - mozversion platform_buildid: 20160531083039 11:23:33 INFO - mozversion platform_changeset: 6617e62776cdf01627f146087690cfc7c883508a 11:23:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:23:33 INFO - mozversion platform_version: 49.0a1 11:23:33 INFO - using testdate: 1464719013 11:23:33 INFO - actual date: 1464719013 11:23:33 INFO - starting webserver on 'localhost:56527' 11:23:33 INFO - SUITE-START | Running 2 tests 11:23:33 INFO - TEST-START | dromaeo_css 11:23:33 INFO - operating with platform_type : linux_ 11:23:33 INFO - Initialising browser for dromaeo_css test... 11:23:33 INFO - TEST-INFO | started process 3299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaI2h5R/profile http://localhost:56527/getInfo.html) 11:23:39 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 11:23:39 INFO - PROCESS | 3299 | colorDepth:24 11:23:39 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 11:23:39 INFO - PROCESS | 3299 | __metrics 11:23:41 ERROR - PROCESS | 3299 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:23:41 INFO - TEST-INFO | 3299: exit 0 11:23:41 INFO - Browser initialized. 11:23:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:41 INFO - TEST-INFO | started process 3379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaI2h5R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:53 INFO - PROCESS | 3379 | RSS: Main: 155537408 11:23:53 INFO - PROCESS | 3379 | 11:24:45 INFO - PROCESS | 3379 | 1464719085018 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] 11:26:53 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56527/tests/dromaeo/cssquery-ext.html) 11:26:54 INFO - PROCESS | 3379 | RSS: Main: 273334272 11:26:54 INFO - PROCESS | 3379 | 11:29:57 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-ext.html (next: http://localhost:56527/tests/dromaeo/cssquery-jquery.html) 11:29:57 INFO - PROCESS | 3379 | RSS: Main: 249049088 11:29:57 INFO - PROCESS | 3379 | 11:32:59 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56527/tests/dromaeo/cssquery-mootools.html) 11:33:00 INFO - PROCESS | 3379 | RSS: Main: 245080064 11:33:00 INFO - PROCESS | 3379 | 11:36:02 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56527/tests/dromaeo/cssquery-prototype.html) 11:36:02 INFO - PROCESS | 3379 | RSS: Main: 241938432 11:36:02 INFO - PROCESS | 3379 | 11:39:05 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56527/tests/dromaeo/cssquery-yui.html) 11:39:06 INFO - PROCESS | 3379 | RSS: Main: 228954112 11:39:06 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:56527/tests/dromaeo/cssquery-yui.html (next: http://localhost:56527/tests/dromaeo/cssquery-dojo.html) 11:42:09 INFO - PROCESS | 3379 | RSS: Main: 255979520 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | __start_tp_report 11:42:09 INFO - PROCESS | 3379 | _x_x_mozilla_page_load 11:42:09 INFO - PROCESS | 3379 | _x_x_mozilla_page_load_details 11:42:09 INFO - PROCESS | 3379 | |i|pagename|runs| 11:42:09 INFO - PROCESS | 3379 | |0;dojo.html;3115.1900505868475;3124.0627811656495;3148.952765708514;3163.873445062198;3179.618445786506;5279.894402111955;5332.093544097503;5347.786088556453;5406.513413792758;5423.322084739408;5334.679919204841;5334.759935802888;5424.945750542493;5499.532539734128;5519.69641669708;4799.064182484417;4827.927581086269;4977.601791856661;5039.924401133986;5099.59203263738;4977.776000079987;5018.222175562793;5027.773750181233;5040.117979353617;5043;4831.975840120795;4891.339669144655;4923.4091908970795;4952.059108769322;4956.578690811285;4968.453470118284;4981.178105612569;4982.153033984195;4984.800607975677;5010.223415370623;4801;4936.925946110811;4953.5541801237705;4973.776180071869;5004.074246264453;5289.233061206103;5323.228131920889;5340.866478338034;5342.225377320306;5371.274877891474;5701.201831743518;5857.970710146465;5866;5867.647941123503;5878.294604647427;5700.8859822803315;5774.595778295521;5828.125781132821;5875.764969401219;5886;5454.863628409282;5517.586181036439;5517.862053448696;5521.199426083195;5522.006038912994;6033.219951833536;6041.9810946063435;6044.375675702444;6084.0265557511475;6090.543209259324;5641.52047075995;5693.772249109989;5785.218995435563;5836.4747172753805;5840.3575606683235;5695.601307908407;5732.426757324318;5767.509761670221;5767.682777447197;5775.797847075416;5736.713164341766;5739.397363276879;5744.597878148489;5746.712664366849;5751.482366587027;5732.914006289909;5769.423057694197;5776.45123713255;5781.508571771363;5786.247787787561;4375.649948004152;4397.362382454527;4404.6035856772405;4407.537208593116;4412.205802955499;3932.0366510204612;3945.467361906163;3962.0689138052535;3970.285348637215;3990.4213888985932;5471.398146203915;5474.343078830566;5476.096444086681;5484.122540393518;5485.286912701324;5745.8563535911935;5813.040848260074;5822.446867547576;5835.649861008353;5907.852303692442;5504.4770746778995;5516;5533.667979921218;5536.529395001389;5598.552115830806;5050.368703912011;5050.3939527256225;5053.343065401475;5065.265536497261;5097.311862898536;5902.61632993854;5907.793227237026;5914.76340946366;6088.512918966472;6095.085737139376;5804.158397032491;5805.854853628524;5860.648361098348;5864.9413505864395;5866.472017518444;5957.6127551709;5965.313988891333;5973.820785376446;5982.58121931478;5983.282006159115;5588.273524441796;5646.915296270641;5657.4908258256955;5660.320761508646;5708.229389032427;5842.737076831468;5856.853578660568;5913.142594323885;5943.227380440515;5964.880702385841;5683.8863222736145;5733.627314224562;5735.54115670737;5739.9139012914;5744.42555744439;5491.643043202179;5574.498295153456;5744.770209191585;5748.5688573358;5758.683272420057;5515.172724091419;5556.972215138899;5567.248421463212;5570.053090974625;5618.353889302783;5691.373948865705;5750.30996280449;5753.712314384347;5759.337676167294;5759.424057594375;5452.127659574449;5500.1749737539685;5577.163425486209;5577.972110139423;5613.859653508532 11:42:09 INFO - PROCESS | 3379 | |1;ext.html;571.6341541413497;608.9634621922685;618.7401291457587;625.9999999999999;638.8466767975685;31226.375472490567;43592;44471.77764111183;44478.55521444784;44596.77701611487;42939.57060429403;43510.782446087724;43549.78225108878;43604.345934811005;43626.78186609071;8519.74440766778;8676.65293388267;8691.869621955675;8698.826023479527;8700.129987001312;8624.137586241388;8674.696385626505;8753.47479151253;8768.868466973001;8769.736907892773;8715.215630593246;8799.428037177595;8811.95594022029;8812.515311657857;8813.338999575026;8730.650773969033;8770.912290877073;8781.604827782734;8783.12168783123;8789.505784016732;8666.696665616737;8741;8753.7811554711;8755.737327880173;8758.781030474289;41212.38181427281;41735;41743.37384939229;41744.582554174674;41751.791241043604;3493.266414053052;3575.4458059000635;3618.3486972344967;3744.3821769408014;4012.3981402789523;31709.524357134662;31959.680403195904;32262.838685806655;32315.353692926245;33439.832800836084;3904.7071469639604;4021.537523184842;4040.8585699500377;4087.7547347159266;4133.441985332001;294804;296140.5192974043;296432;296594;296944;54887.45112548823;54909;54961.450385496435;55202.72398637981;55336.72331638396;59145;59161.70419147877;59688.10467842986;59751;59791.40208597858;13350.465981360638;13447.596572102853;13451.932740336431;13469.057165998285;13480.191188528719;9913.80172396548;9918.40489570628;9919.107280344804;9924.900750992541;9968.352057116264;14695.853041469449;16051.197440127948;16285.755713664304;16350.427735029454;16462.92990955584;5579.107342825209;6510.121133646991;6596.835079122964;6797.524173307821;6877.423739655451;939.4832841937044;1027.6916924922493;1029.459533744775;1078.8597482327405;1084.159776173456;32034.623380777357;32494.050356978656;32604.836975815444;32893.67106328954;32897.83551082229;1171.3674615707423;1180.2505409065134;1190.4642910690225;1229.8647148813623;1230.39095647655;16521.33914643425;16631.251593678313;16813.991160530408;17007.319707211573;17070.48788536346;507426;510831;510980;511038;512359;57146;57432;57438.7128064357;57462.7126864363;57499.13751293734;1232.2914324263404;1307.1176955554963;1365.5357178559339;1366.5285476510587;1376.5457399058487;32510;33606;33705.66294337124;33835.661643384236;34210.48684269788;50236.49763502318;50551.49448505468;50748.23877641912;50752.746236268584;50761.74619126881;396036;398802;399245;399319;400541;32537.511937320487;41068.794656026526;41618;44269.778651106535;44789;48281;48443.51556484531;48775.26837097517;49582.752086239336;49661.75169124276;39045.6095439042;41147.1770564593;41202.587974121074;43442.78278608587;44968.55031449644;41541.79229103835;41680.791596041825;41933.58066419297;42315.5768442324;42619;40605.18789624132;41410.37884431676;41851.372229415974;42066;42360.1527969445;35819.462708058876;37484;38077.61922380741;38239.61760382361;38248.808755956044;28564.857175713987;28862.567061493675;28983.275418114717;29037.419251615273;29094.854525727234 11:42:09 INFO - PROCESS | 3379 | |2;jquery.html;386.3644305118083;391.40311025685816;394.77103280097526;394.91311911379495;416.5792549524979;14235.71528569428;16622.418215362464;18285.725714114284;19689.901550492265;19830.70253946192;14723.411063557473;14732.33704483298;17624.735628965576;17978.460646180603;18042.5489362766;5455.427180146087;5637.041702910495;5646.26598542191;5661.433856614347;5678.290213723285;4001.399790031504;5449.509544141027;5658.264425624684;5658.688772117532;5664.688442135681;4600.332951721998;6259.655718935457;6260.843478913018;6349.492040636761;6361.713722882459;6256.593321434115;6310.558260921737;6331.2719037310835;6338.08097825815;6348.682565871688;5509.449055094458;5631.2960879890015;5639.68981706006;5643.943560564424;5661.745221465044;21973.450663733376;22315.218967336066;22867.085316587316;23340.2997910063;23370.883145584332;2321.0947730385165;2327.790498855094;2351.4882301091952;2377.9881100594384;2395.6286775549816;13162;14095.436182552789;14133.929330353283;14647.70704585913;14709.485168019175;1865.7481240032557;1928.9903550482297;1950.5123719070232;1965.4791480257743;2052.056054215063;78921;79151;80504;80649.19350806533;81099.5945020277;10366.378017318984;10519.684409467729;10597.364158150536;10670.466476676134;10873.782524349468;14801.851981480262;15007.924960375129;15028.699426011419;15051;15052.54842354731;6782.253952065269;6812.659367031629;7022.6488675566015;7098.290170982964;7282.781516554512;6772.390484856386;6800.965995169992;6807.0810440589885;6948.722051117999;7014.754483593049;6528.902066469007;6540;6566.507511936624;6590.835229119214;6790.456763458911;1744.9389271375694;1757.4991127528592;1894.8966647021796;1917.5014496230801;1926.2776458827939;877.5129802959291;940;1032.8863824979246;1097.2154909239932;1158.1834806461425;18653.253869845325;18670.919298315624;19060.237590496225;19308.32420865263;19755;989.9851502227473;1028.3521381529588;1034.5603118674533;1037.6938803053117;1072.2172813845937;10786.838197427045;11269.154813388865;11278.492467838967;11286.548538058385;11287.887121128848;467924;475412;495801;496249;496525;58572.414275856696;79620.6018969913;100840.49579752202;103257;103738.48130759299;985.7190700650424;1022.3814592171777;1040.0691381213921;1040.0743338428804;1048.7902419516126;17305.39431119905;17455.738163927297;17770.200340984946;17773.911130444267;17991.190396432452;42016.15967680691;42334.57665423306;42605.36091958685;43497.13005739804;43792.78103609462;60194.69902650459;60516.69741651264;60879.391206089145;61234.69382653058;63271.05093423694;6869.175698916162;7345.3021962913435;7495.587742674205;7639;7675.884861726967;10053.899461005296;13219.272939988394;13389.263590502616;13423.597292081253;13581.11722738019;11591.24656897299;11798.705032374259;11949.522019119486;12003.699907502032;12123.575674851338;11427.657170284905;11659.883401166218;11665.125115616192;11759.294442333487;11862.562420809489;11893.345865977455;11987;12049.156559040783;12160.087993400353;12200.572979945659;7537.736179233701;7641.923580764121;7659.1192012917;7748.496347737379;7805.375569954276;9313.44119352841;11930.164888458072;11973.161878668758;12097.697557561132;12136.696582585506 11:42:09 INFO - PROCESS | 3379 | |3;mootools.html;1326.4016859684082;1507.1559926441191;1529.6328881068541;1707.6840784454878;1832.6701193785123;8359.122292159327;8703.56482175891;8709.869351959718;8897.733068007954;8924.55377231139;8171.509709417439;8300.50196988181;8306.08633050364;8350.95824520878;8362.16378362165;1988.4034789563145;2047.1299697628522;2064.225915281769;2284.79436850683;2308.4344335637793;2200.3508964855405;2267.455810605459;2277.4761804784907;2278.4873403484166;2289.69089172962;2190.200576789476;2213.269621025058;2223.844330896838;2226.3432287475152;2293.4037150340946;1952.0142328124348;2210.2706106984656;2285.211601997308;2300.1604414388794;2305.7463678995296;2098.748150221968;2115.471132216946;2115.947101322464;2117.396541985542;2126.755423126345;8652.437591556529;8665.090165532654;8694.347923905732;8701.129887011311;8708.216260536583;5057.924131138036;5170.6122040847085;5172.2241663750365;5178.042062218502;5189.117849965515;3121.7190452859127;3208.0856955767495;3251.6260630027614;3252.235724604716;3258.706716395512;1049.632628579991;1067.4502631144967;1073.3667136389568;1075.1022895881947;1109.051760744568;12518.624441266777;12722.173058751245;12749.808752868714;12788;12799.5520156795;4523.683342166017;4633.745144017044;4639.443266807937;4643.582077612963;4643.883902902387;10884.782304353868;10902.781944361226;10904.400257985886;10930.672079837617;10943.781124377469;5234.685918844805;5247.921281180786;5249.133892907704;5251.737413129328;5266.1574148136115;4225.239456897726;4567.132244873464;4633.72197668141;4711.882202944954;4740.502247264057;3980.24375368679;3991.221711766236;4046.1503084352025;4082.040720430696;4160.625543701081;1236.412703965627;1238.3746208164819;1255.5856567332758;1267.5056727876135;1290.9289989050692;806.4113197365956;877.2411863737948;940.5626383731598;973.3867663372031;1012.6658202793061;6084.39156084388;6130.976777663361;6173.41352571505;6248.750049997949;6307.3377295383325;437.58210908582225;444.83541089796984;449.34171438842253;456.2494696224692;471.5311803731352;4077.429159917614;4095.6723462123555;4299.269124248885;4310.245707001262;4339.1104823511105;11215.383153926612;11442.427878606037;11528.481218345194;11537.19239653233;11579.76840463186;11144.275622084539;11326.263792853439;11369.2609980351;11414.94292528532;11432.657020289405;8202.507849529047;8453.365997550209;8460.746177614681;8476.152384761475;8478.533680647624;6045.21412216409;6097.237845269341;6226.972549529277;6309.400606942333;6394.23269207698;10174.694759157237;10324.690259292232;10458.581656733646;10606.416647084485;10621.468926553487;10540.420276884844;10642.255042146975;10762.246642734934;10766.246362754531;10771.784564308826;7169.175544812205;7738.92261077382;7803.258690424401;8003.879941800994;8050.758477245692;8829.38194326391;8876.467411955304;8881.42270752399;8892.15524525169;8950.373473856767;7643.7324693635455;7859.056913170456;7871.173526779835;7919.247671471201;7922;7411.370033546993;7723;7749;7832.177621349676;7976.601169941596;6945.0971373721095;7122.7507037253445;7124.430045596237;7146.678399471933;7154.713811447484;5000.524950129732;5127.128388173945;5179.948200517946;5320.813771517978;5358.624896257381;5262.6316157870115;5377.489138531833;5408.323959505062;5456.127019676833;5610.775568977195 11:42:09 INFO - PROCESS | 3379 | |4;prototype.html;306.31996966733846;320.64888946603475;322.16077119104716;322.5645378738703;331.0895038643729;5080.822171224008;5159.303494028305;5233.398159211692;5254.632175747694;5261.421243663194;5199.662021968569;5208.973955130219;5211.80128570429;5214.348206474191;5222;4067.491563554556;4074.5314288856716;4080.7959602019855;4104.733192342503;4151.40171034151;3827.8468861245656;3890.1441682829873;4073.348264277716;4101.2207680540605;4114.156597897424;4025.838966441339;4036.919261614766;4054.898627534306;4067.532233793122;4077.531083925342;4026.11425486394;4046.693384770682;4046.898827529306;4068.837246510136;4089.672826173899;3550.3076900004507;3623.5108260384773;3624.9637503625154;3637.1634524059614;3641.635836416364;4928.876778080541;4995.325631039799;5008.24876268559;5068.189089745623;5087.643864929457;4563.315502674625;4599.471060828014;4599.701019433726;4605.83879564217;4606.355110284563;5230.8169214077325;5378.139497680391;5424.593155513313;5455;5461.924468701907;3880.6313400227214;3893.201893611803;3910.1397692507603;3914.178022615254;3919.118198405336;5655.349634792011;5704.942950570483;5715.342735585377;5736.651886806597;5751.568632352591;3842.7502212356108;3950.802459876995;3964.2269757397607;3992.0219546211365;3995.700322475826;3983.183447393277;3998.6204759357975;4011.1777085697363;4033.1127152026506;4041.474608300902;4641.744704041243;4665.4168228971375;4672.462666793363;4673.481118636457;4680.765961701902;5263.763130659129;5487.176923461513;5511.724413779295;5536.501714845684;5574.637648552831;1290.922080063139;1327.2832670357898;1336.6658335416146;1346.212465707572;1363.4137320951888;864.3646919514152;890.6481939633937;894.9507777072323;896.0815164456354;898.034612791252;4736.176572019797;4750.477447480775;4772.522747725269;4781.545753153515;4827.275908613736;4758.476567577563;5018.372703412074;5025.492352294297;5151.716655583904;5153.819616313411;4630.58324750774;4632.401821371622;4635.629149668019;4717.787699553528;4720.480747117883;2636.9604455933177;2662.3211081174177;2662.8668566571596;2711.25440503863;2714.24001279642;4827.131116399011;5054.393472783289;5143.228515722597;5166.560842328444;5250.553702935217;5015.874603134878;5020.748962551857;5038.445770965191;5057.216131499624;5111.028904508132;5102.719350435687;5117.948820511747;5133.897322053538;5134.409542902614;5148.704828909501;4778.522147785333;4971.577415919687;4999;5000.324956131021;5003.974980125076;4857.692596016864;4883.755812209304;4903.190973489477;4969.279454479008;4999.200127979506;5076.619253556072;5076.949230507647;5135.589152867837;5149;5150.97424512875;3358.4290670586547;3623.8550457981387;3645.908852278714;3662.1210909381025;3667.651573100551;4938.43208031081;4967.441767489818;4974.562464392494;4991.5258050485145;5006.974965125297;4834.492378300369;4871.805127794849;4890.168671325812;4907.386576677915;4916.532929371704;4889.555222388805;4906.607471402351;5012.248162775612;5275.261463395051;5332.173513105475;5372.677639341496;5373.623846330719;5374.704391258519;5393.8112166074;5415.377231618414;5452.345718513804;5470.480304371078;5515.889682206253;5519.69641669712;5534.142207957773;5165.535101840853;5365.248865158803;5376.973115134556;5429.511343979061;5453.318335208099 11:42:09 INFO - PROCESS | 3379 | |5;yui.html;825.8802473641322;853.7652145659939;863.1411745313412;869.4609342207832;888.6045709659201;14859.182744949037;15458.1498017609;15619.765703514457;15641.217939103042;15643.139627320521;14002.439902403892;14533.563993080197;14538.781918271234;14540.418383264683;14557.854421455782;685.8662560800645;799.3684988858795;820.9302209312216;828.9295409890167;829.8589239829244;834.5451728807815;834.56185502611;836.9707060252892;837.4431003382743;837.5226121110969;864.4813112132701;864.5417928497906;865.9740207793776;866.0733015673201;866.077627326898;709.8083517450285;842.540815255684;852.7868032991752;861.573521107056;862.6463150108489;627.0312367392389;630.3664816859027;630.6468377708497;631.5326658272845;631.782035197856;14134.717305653829;14231.647993440607;14238.216898070603;14250.073745206528;14256.35846386915;13812.37844297009;13921.443142274296;14042.087264327785;14066.226357550433;14278.357473913698;11861.762764744743;11939.104567157498;11972.64082077539;12004.759904801942;12014.159008869383;4498.302763071729;4501.549845015505;4590.081983603292;4605.470370907322;4611.815527378901;59274;59472.702636486974;59477.40522594805;59985.70007149936;60462.093068604445;11324.207305488702;11335.149863760085;11434.199606027498;11477.311361318347;11505.194636375541;20512.58974820525;20570.58858822815;20575.4856128595;20637.380878573666;20642.690359644617;7968.163342849033;8022.679092836222;8045.115037345888;8091.716789912325;8125.512469251864;4313.6980411370905;4407.911841763147;4433.423654924839;4491.595756381941;4632.675712700146;3318.469044952796;3363.5963684358035;3386.508956201337;3410.334984677964;3422.760406771552;614.757170917485;617.305531277313;621.6518749500204;631.210986267166;642.0337392224671;541.0450554770832;626.9529785266124;628.6887990444759;695.4957655699577;751.2149803455402;9551.808963820684;9690.567086822975;9770.658026969022;9776.120149186607;9917.157041651397;710.6517806274888;719.1801346465035;726.2700985509529;728.9198188199293;750.8798592225218;4357.694961352675;4599.862004139881;4659.534046595313;4764.2615394613895;4859.07677541266;57856;59467.40532594619;60213.39786602165;62249;67800.3219967794;60711.08933366003;61263.38736612577;61476;61796;62230.68884655638;49909.50090499121;50185.74907125441;50366.748166258934;54804.451955480734;55993.720031399585;10050.19598432109;10181.898181018096;10221.185458560833;10262.743431414274;10494.160467162761;36829.63170368369;37432.625673742914;37528;37867.62132378641;38462.42306365351;45471.77264113658;48301.75849120732;48601.513984861114;48920.75539622279;50046.749766250934;12586.322343370719;12816.743665126458;12848.42182101789;12926.095173337777;12947.28789916526;13993.720125597634;14256.786148207993;14525.709485810014;14605.488807891672;14664.486742963945;13158.60524184276;13495.527656531975;13592.66018349549;13807.309634518033;13920.234387108807;13069.467124088225;13262.734745304846;13316;13537.390817413043;13708.177509349072;12976.351182441029;13092.214467132002;13112.409941552462;13112.409941552462;13135.73728525405;10838.783224335626;10997.230193886351;11231;11380.089592832388;11633.243839150427;10808.601829010055;11086.946740059682;11474.311541307214;11479.139064570023;11495.942520287344 11:42:09 INFO - PROCESS | 3379 | __end_tp_report 11:42:09 INFO - PROCESS | 3379 | __start_cc_report 11:42:09 INFO - PROCESS | 3379 | _x_x_mozilla_cycle_collect,925 11:42:09 INFO - PROCESS | 3379 | __end_cc_report 11:42:09 INFO - PROCESS | 3379 | __startTimestamp1464720129309__endTimestamp 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | ------- Summary: start ------- 11:42:09 INFO - PROCESS | 3379 | Number of tests: 6 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#0] dojo.html Cycles:165 Average:5398.57 Median:5577.16 stddev:614.09 (11.0%) stddev-sans-first:589.27 11:42:09 INFO - PROCESS | 3379 | Values: 3115.2 3124.1 3149.0 3163.9 3179.6 5279.9 5332.1 5347.8 5406.5 5423.3 5334.7 5334.8 5424.9 5499.5 5519.7 4799.1 4827.9 4977.6 5039.9 5099.6 4977.8 5018.2 5027.8 5040.1 5043.0 4832.0 4891.3 4923.4 4952.1 4956.6 4968.5 4981.2 4982.2 4984.8 5010.2 4801.0 4936.9 4953.6 4973.8 5004.1 5289.2 5323.2 5340.9 5342.2 5371.3 5701.2 5858.0 5866.0 5867.6 5878.3 5700.9 5774.6 5828.1 5875.8 5886.0 5454.9 5517.6 5517.9 5521.2 5522.0 6033.2 6042.0 6044.4 6084.0 6090.5 5641.5 5693.8 5785.2 5836.5 5840.4 5695.6 5732.4 5767.5 5767.7 5775.8 5736.7 5739.4 5744.6 5746.7 5751.5 5732.9 5769.4 5776.5 5781.5 5786.2 4375.6 4397.4 4404.6 4407.5 4412.2 3932.0 3945.5 3962.1 3970.3 3990.4 5471.4 5474.3 5476.1 5484.1 5485.3 5745.9 5813.0 5822.4 5835.6 5907.9 5504.5 5516.0 5533.7 5536.5 5598.6 5050.4 5050.4 5053.3 5065.3 5097.3 5902.6 5907.8 5914.8 6088.5 6095.1 5804.2 5805.9 5860.6 5864.9 5866.5 5957.6 5965.3 5973.8 5982.6 5983.3 5588.3 5646.9 5657.5 5660.3 5708.2 5842.7 5856.9 5913.1 5943.2 5964.9 5683.9 5733.6 5735.5 5739.9 5744.4 5491.6 5574.5 5744.8 5748.6 5758.7 5515.2 5557.0 5567.2 5570.1 5618.4 5691.4 5750.3 5753.7 5759.3 5759.4 5452.1 5500.2 5577.2 5578.0 5613.9 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#1] ext.html Cycles:180 Average:57040.08 Median:41892.48 stddev:108853.32 (259.8%) stddev-sans-first:109076.12 11:42:09 INFO - PROCESS | 3379 | Values: 571.6 609.0 618.7 626.0 638.8 31226.4 43592.0 44471.8 44478.6 44596.8 42939.6 43510.8 43549.8 43604.3 43626.8 8519.7 8676.7 8691.9 8698.8 8700.1 8624.1 8674.7 8753.5 8768.9 8769.7 8715.2 8799.4 8812.0 8812.5 8813.3 8730.7 8770.9 8781.6 8783.1 8789.5 8666.7 8741.0 8753.8 8755.7 8758.8 41212.4 41735.0 41743.4 41744.6 41751.8 3493.3 3575.4 3618.3 3744.4 4012.4 31709.5 31959.7 32262.8 32315.4 33439.8 3904.7 4021.5 4040.9 4087.8 4133.4 294804.0 296140.5 296432.0 296594.0 296944.0 54887.5 54909.0 54961.5 55202.7 55336.7 59145.0 59161.7 59688.1 59751.0 59791.4 13350.5 13447.6 13451.9 13469.1 13480.2 9913.8 9918.4 9919.1 9924.9 9968.4 14695.9 16051.2 16285.8 16350.4 16462.9 5579.1 6510.1 6596.8 6797.5 6877.4 939.5 1027.7 1029.5 1078.9 1084.2 32034.6 32494.1 32604.8 32893.7 32897.8 1171.4 1180.3 1190.5 1229.9 1230.4 16521.3 16631.3 16814.0 17007.3 17070.5 507426.0 510831.0 510980.0 511038.0 512359.0 57146.0 57432.0 57438.7 57462.7 57499.1 1232.3 1307.1 1365.5 1366.5 1376.5 32510.0 33606.0 33705.7 33835.7 34210.5 50236.5 50551.5 50748.2 50752.7 50761.7 396036.0 398802.0 399245.0 399319.0 400541.0 32537.5 41068.8 41618.0 44269.8 44789.0 48281.0 48443.5 48775.3 49582.8 49661.8 39045.6 41147.2 41202.6 43442.8 44968.6 41541.8 41680.8 41933.6 42315.6 42619.0 40605.2 41410.4 41851.4 42066.0 42360.2 35819.5 37484.0 38077.6 38239.6 38248.8 28564.9 28862.6 28983.3 29037.4 29094.9 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#2] jquery.html Cycles:180 Average:28843.44 Median:12594.09 stddev:80266.69 (637.3%) stddev-sans-first:80463.42 11:42:09 INFO - PROCESS | 3379 | Values: 386.4 391.4 394.8 394.9 416.6 14235.7 16622.4 18285.7 19689.9 19830.7 14723.4 14732.3 17624.7 17978.5 18042.5 5455.4 5637.0 5646.3 5661.4 5678.3 4001.4 5449.5 5658.3 5658.7 5664.7 4600.3 6259.7 6260.8 6349.5 6361.7 6256.6 6310.6 6331.3 6338.1 6348.7 5509.4 5631.3 5639.7 5643.9 5661.7 21973.5 22315.2 22867.1 23340.3 23370.9 2321.1 2327.8 2351.5 2378.0 2395.6 13162.0 14095.4 14133.9 14647.7 14709.5 1865.7 1929.0 1950.5 1965.5 2052.1 78921.0 79151.0 80504.0 80649.2 81099.6 10366.4 10519.7 10597.4 10670.5 10873.8 14801.9 15007.9 15028.7 15051.0 15052.5 6782.3 6812.7 7022.6 7098.3 7282.8 6772.4 6801.0 6807.1 6948.7 7014.8 6528.9 6540.0 6566.5 6590.8 6790.5 1744.9 1757.5 1894.9 1917.5 1926.3 877.5 940.0 1032.9 1097.2 1158.2 18653.3 18670.9 19060.2 19308.3 19755.0 990.0 1028.4 1034.6 1037.7 1072.2 10786.8 11269.2 11278.5 11286.5 11287.9 467924.0 475412.0 495801.0 496249.0 496525.0 58572.4 79620.6 100840.5 103257.0 103738.5 985.7 1022.4 1040.1 1040.1 1048.8 17305.4 17455.7 17770.2 17773.9 17991.2 42016.2 42334.6 42605.4 43497.1 43792.8 60194.7 60516.7 60879.4 61234.7 63271.1 6869.2 7345.3 7495.6 7639.0 7675.9 10053.9 13219.3 13389.3 13423.6 13581.1 11591.2 11798.7 11949.5 12003.7 12123.6 11427.7 11659.9 11665.1 11759.3 11862.6 11893.3 11987.0 12049.2 12160.1 12200.6 7537.7 7641.9 7659.1 7748.5 7805.4 9313.4 11930.2 11973.2 12097.7 12136.7 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#3] mootools.html Cycles:180 Average:5870.96 Median:2489.97 stddev:3466.75 (139.2%) stddev-sans-first:3459.65 11:42:09 INFO - PROCESS | 3379 | Values: 1326.4 1507.2 1529.6 1707.7 1832.7 8359.1 8703.6 8709.9 8897.7 8924.6 8171.5 8300.5 8306.1 8351.0 8362.2 1988.4 2047.1 2064.2 2284.8 2308.4 2200.4 2267.5 2277.5 2278.5 2289.7 2190.2 2213.3 2223.8 2226.3 2293.4 1952.0 2210.3 2285.2 2300.2 2305.7 2098.7 2115.5 2115.9 2117.4 2126.8 8652.4 8665.1 8694.3 8701.1 8708.2 5057.9 5170.6 5172.2 5178.0 5189.1 3121.7 3208.1 3251.6 3252.2 3258.7 1049.6 1067.5 1073.4 1075.1 1109.1 12518.6 12722.2 12749.8 12788.0 12799.6 4523.7 4633.7 4639.4 4643.6 4643.9 10884.8 10902.8 10904.4 10930.7 10943.8 5234.7 5247.9 5249.1 5251.7 5266.2 4225.2 4567.1 4633.7 4711.9 4740.5 3980.2 3991.2 4046.2 4082.0 4160.6 1236.4 1238.4 1255.6 1267.5 1290.9 806.4 877.2 940.6 973.4 1012.7 6084.4 6131.0 6173.4 6248.8 6307.3 437.6 444.8 449.3 456.2 471.5 4077.4 4095.7 4299.3 4310.2 4339.1 11215.4 11442.4 11528.5 11537.2 11579.8 11144.3 11326.3 11369.3 11414.9 11432.7 8202.5 8453.4 8460.7 8476.2 8478.5 6045.2 6097.2 6227.0 6309.4 6394.2 10174.7 10324.7 10458.6 10606.4 10621.5 10540.4 10642.3 10762.2 10766.2 10771.8 7169.2 7738.9 7803.3 8003.9 8050.8 8829.4 8876.5 8881.4 8892.2 8950.4 7643.7 7859.1 7871.2 7919.2 7922.0 7411.4 7723.0 7749.0 7832.2 7976.6 6945.1 7122.8 7124.4 7146.7 7154.7 5000.5 5127.1 5179.9 5320.8 5358.6 5262.6 5377.5 5408.3 5456.1 5610.8 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#4] prototype.html Cycles:180 Average:4379.68 Median:4907.00 stddev:1258.99 (25.7%) stddev-sans-first:1224.84 11:42:09 INFO - PROCESS | 3379 | Values: 306.3 320.6 322.2 322.6 331.1 5080.8 5159.3 5233.4 5254.6 5261.4 5199.7 5209.0 5211.8 5214.3 5222.0 4067.5 4074.5 4080.8 4104.7 4151.4 3827.8 3890.1 4073.3 4101.2 4114.2 4025.8 4036.9 4054.9 4067.5 4077.5 4026.1 4046.7 4046.9 4068.8 4089.7 3550.3 3623.5 3625.0 3637.2 3641.6 4928.9 4995.3 5008.2 5068.2 5087.6 4563.3 4599.5 4599.7 4605.8 4606.4 5230.8 5378.1 5424.6 5455.0 5461.9 3880.6 3893.2 3910.1 3914.2 3919.1 5655.3 5704.9 5715.3 5736.7 5751.6 3842.8 3950.8 3964.2 3992.0 3995.7 3983.2 3998.6 4011.2 4033.1 4041.5 4641.7 4665.4 4672.5 4673.5 4680.8 5263.8 5487.2 5511.7 5536.5 5574.6 1290.9 1327.3 1336.7 1346.2 1363.4 864.4 890.6 895.0 896.1 898.0 4736.2 4750.5 4772.5 4781.5 4827.3 4758.5 5018.4 5025.5 5151.7 5153.8 4630.6 4632.4 4635.6 4717.8 4720.5 2637.0 2662.3 2662.9 2711.3 2714.2 4827.1 5054.4 5143.2 5166.6 5250.6 5015.9 5020.7 5038.4 5057.2 5111.0 5102.7 5117.9 5133.9 5134.4 5148.7 4778.5 4971.6 4999.0 5000.3 5004.0 4857.7 4883.8 4903.2 4969.3 4999.2 5076.6 5076.9 5135.6 5149.0 5151.0 3358.4 3623.9 3645.9 3662.1 3667.7 4938.4 4967.4 4974.6 4991.5 5007.0 4834.5 4871.8 4890.2 4907.4 4916.5 4889.6 4906.6 5012.2 5275.3 5332.2 5372.7 5373.6 5374.7 5393.8 5415.4 5452.3 5470.5 5515.9 5519.7 5534.1 5165.5 5365.2 5377.0 5429.5 5453.3 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - PROCESS | 3379 | [#5] yui.html Cycles:180 Average:15684.69 Median:4499.93 stddev:18172.34 (403.8%) stddev-sans-first:18189.06 11:42:09 INFO - PROCESS | 3379 | Values: 825.9 853.8 863.1 869.5 888.6 14859.2 15458.1 15619.8 15641.2 15643.1 14002.4 14533.6 14538.8 14540.4 14557.9 685.9 799.4 820.9 828.9 829.9 834.5 834.6 837.0 837.4 837.5 864.5 864.5 866.0 866.1 866.1 709.8 842.5 852.8 861.6 862.6 627.0 630.4 630.6 631.5 631.8 14134.7 14231.6 14238.2 14250.1 14256.4 13812.4 13921.4 14042.1 14066.2 14278.4 11861.8 11939.1 11972.6 12004.8 12014.2 4498.3 4501.5 4590.1 4605.5 4611.8 59274.0 59472.7 59477.4 59985.7 60462.1 11324.2 11335.1 11434.2 11477.3 11505.2 20512.6 20570.6 20575.5 20637.4 20642.7 7968.2 8022.7 8045.1 8091.7 8125.5 4313.7 4407.9 4433.4 4491.6 4632.7 3318.5 3363.6 3386.5 3410.3 3422.8 614.8 617.3 621.7 631.2 642.0 541.0 627.0 628.7 695.5 751.2 9551.8 9690.6 9770.7 9776.1 9917.2 710.7 719.2 726.3 728.9 750.9 4357.7 4599.9 4659.5 4764.3 4859.1 57856.0 59467.4 60213.4 62249.0 67800.3 60711.1 61263.4 61476.0 61796.0 62230.7 49909.5 50185.7 50366.7 54804.5 55993.7 10050.2 10181.9 10221.2 10262.7 10494.2 36829.6 37432.6 37528.0 37867.6 38462.4 45471.8 48301.8 48601.5 48920.8 50046.7 12586.3 12816.7 12848.4 12926.1 12947.3 13993.7 14256.8 14525.7 14605.5 14664.5 13158.6 13495.5 13592.7 13807.3 13920.2 13069.5 13262.7 13316.0 13537.4 13708.2 12976.4 13092.2 13112.4 13112.4 13135.7 10838.8 10997.2 11231.0 11380.1 11633.2 10808.6 11086.9 11474.3 11479.1 11495.9 11:42:09 INFO - PROCESS | 3379 | -------- Summary: end -------- 11:42:09 INFO - PROCESS | 3379 | 11:42:09 INFO - TEST-INFO | 3379: exit 0 11:42:09 INFO - TEST-OK | dromaeo_css | took 1116031ms 11:42:09 INFO - TEST-START | kraken 11:42:09 INFO - operating with platform_type : linux_ 11:42:09 INFO - Initialising browser for kraken test... 11:42:09 INFO - TEST-INFO | started process 3562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_6exx/profile http://localhost:56527/getInfo.html) 11:42:14 INFO - PROCESS | 3562 | __metrics Screen width/height:1600/1200 11:42:14 INFO - PROCESS | 3562 | colorDepth:24 11:42:14 INFO - PROCESS | 3562 | Browser inner width/height: 1024/697 11:42:14 INFO - PROCESS | 3562 | __metrics 11:42:15 ERROR - PROCESS | 3562 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:42:16 INFO - TEST-INFO | 3562: exit 0 11:42:16 INFO - Browser initialized. 11:42:16 INFO - Running cycle 1/1 for kraken test... 11:42:16 INFO - TEST-INFO | started process 3642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_6exx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:28 INFO - PROCESS | 3642 | RSS: Main: 155447296 11:42:28 INFO - PROCESS | 3642 | 11:42:30 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56527/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:31 INFO - PROCESS | 3642 | RSS: Main: 213757952 11:42:31 INFO - PROCESS | 3642 | 11:42:34 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56527/tests/kraken/driver.html?testName=audio-dft) 11:42:34 INFO - PROCESS | 3642 | RSS: Main: 198385664 11:42:34 INFO - PROCESS | 3642 | 11:42:37 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56527/tests/kraken/driver.html?testName=audio-fft) 11:42:38 INFO - PROCESS | 3642 | RSS: Main: 268877824 11:42:38 INFO - PROCESS | 3642 | 11:42:40 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56527/tests/kraken/driver.html?testName=audio-oscillator) 11:42:41 INFO - PROCESS | 3642 | RSS: Main: 179761152 11:42:41 INFO - PROCESS | 3642 | 11:42:43 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:43 INFO - PROCESS | 3642 | RSS: Main: 183623680 11:42:43 INFO - PROCESS | 3642 | 11:42:46 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56527/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:47 INFO - PROCESS | 3642 | RSS: Main: 219381760 11:42:47 INFO - PROCESS | 3642 | 11:42:50 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56527/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:51 INFO - PROCESS | 3642 | RSS: Main: 220684288 11:42:51 INFO - PROCESS | 3642 | 11:42:54 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56527/tests/kraken/driver.html?testName=json-parse-financial) 11:42:54 INFO - PROCESS | 3642 | RSS: Main: 220147712 11:42:54 INFO - PROCESS | 3642 | 11:42:56 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:57 INFO - PROCESS | 3642 | RSS: Main: 207929344 11:42:57 INFO - PROCESS | 3642 | 11:42:58 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:59 INFO - PROCESS | 3642 | RSS: Main: 212180992 11:42:59 INFO - PROCESS | 3642 | 11:43:02 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:02 INFO - PROCESS | 3642 | RSS: Main: 217800704 11:43:02 INFO - PROCESS | 3642 | 11:43:05 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:05 INFO - PROCESS | 3642 | RSS: Main: 224305152 11:43:05 INFO - PROCESS | 3642 | 11:43:08 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:09 INFO - PROCESS | 3642 | RSS: Main: 225345536 11:43:09 INFO - PROCESS | 3642 | 11:43:10 INFO - PROCESS | 3642 | Cycle 1(1): loaded http://localhost:56527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56527/tests/kraken/driver.html?testName=ai-astar) 11:43:11 INFO - PROCESS | 3642 | RSS: Main: 267612160 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | __start_tp_report 11:43:11 INFO - PROCESS | 3642 | _x_x_mozilla_page_load 11:43:11 INFO - PROCESS | 3642 | _x_x_mozilla_page_load_details 11:43:11 INFO - PROCESS | 3642 | |i|pagename|runs| 11:43:11 INFO - PROCESS | 3642 | |0;ai-astar;110;107;113;110;112;110;110;109;109;110 11:43:11 INFO - PROCESS | 3642 | |1;audio-beat-detection;155;131;127;185;126;133;155;128;159;133 11:43:11 INFO - PROCESS | 3642 | |2;audio-dft;160;160;160;160;160;162;161;162;160;161 11:43:11 INFO - PROCESS | 3642 | |3;audio-fft;74;74;73;117;74;78;75;73;96;74 11:43:11 INFO - PROCESS | 3642 | |4;audio-oscillator;82;83;115;83;83;84;115;84;84;130 11:43:11 INFO - PROCESS | 3642 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;116 11:43:11 INFO - PROCESS | 3642 | |6;imaging-darkroom;145;146;146;146;146;146;145;146;145;145 11:43:11 INFO - PROCESS | 3642 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;96;95 11:43:11 INFO - PROCESS | 3642 | |8;json-parse-financial;53;55;52;52;54;52;53;54;54;53 11:43:11 INFO - PROCESS | 3642 | |9;json-stringify-tinderbox;61;60;61;61;61;61;60;61;60;62 11:43:11 INFO - PROCESS | 3642 | |10;stanford-crypto-aes;78;78;80;80;79;85;79;80;114;82 11:43:11 INFO - PROCESS | 3642 | |11;stanford-crypto-ccm;124;123;118;119;125;125;118;120;141;123 11:43:11 INFO - PROCESS | 3642 | |12;stanford-crypto-pbkdf2;161;160;159;161;165;163;163;159;159;156 11:43:11 INFO - PROCESS | 3642 | |13;stanford-crypto-sha256-iterative;62;65;64;64;63;62;62;63;66;62 11:43:11 INFO - PROCESS | 3642 | __end_tp_report 11:43:11 INFO - PROCESS | 3642 | __start_cc_report 11:43:11 INFO - PROCESS | 3642 | _x_x_mozilla_cycle_collect,1618 11:43:11 INFO - PROCESS | 3642 | __end_cc_report 11:43:11 INFO - PROCESS | 3642 | __startTimestamp1464720191113__endTimestamp 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | ------- Summary: start ------- 11:43:11 INFO - PROCESS | 3642 | Number of tests: 14 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.63 (1.5%) stddev-sans-first:1.73 11:43:11 INFO - PROCESS | 3642 | Values: 110.0 107.0 113.0 110.0 112.0 110.0 110.0 109.0 109.0 110.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:144.00 stddev:19.50 (13.5%) stddev-sans-first:20.21 11:43:11 INFO - PROCESS | 3642 | Values: 155.0 131.0 127.0 185.0 126.0 133.0 155.0 128.0 159.0 133.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 11:43:11 INFO - PROCESS | 3642 | Values: 160.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 160.0 161.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.00 stddev:14.49 (19.6%) stddev-sans-first:15.16 11:43:11 INFO - PROCESS | 3642 | Values: 74.0 74.0 73.0 117.0 74.0 78.0 75.0 73.0 96.0 74.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:83.00 stddev:18.21 (21.9%) stddev-sans-first:18.76 11:43:11 INFO - PROCESS | 3642 | Values: 82.0 83.0 115.0 83.0 83.0 84.0 115.0 84.0 84.0 130.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:43:11 INFO - PROCESS | 3642 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:43:11 INFO - PROCESS | 3642 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:43:11 INFO - PROCESS | 3642 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 96.0 95.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.03 (1.9%) stddev-sans-first:1.09 11:43:11 INFO - PROCESS | 3642 | Values: 53.0 55.0 52.0 52.0 54.0 52.0 53.0 54.0 54.0 53.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:43:11 INFO - PROCESS | 3642 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 60.0 61.0 60.0 62.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.00 stddev:10.92 (13.6%) stddev-sans-first:11.40 11:43:11 INFO - PROCESS | 3642 | Values: 78.0 78.0 80.0 80.0 79.0 85.0 79.0 80.0 114.0 82.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.50 stddev:6.70 (5.4%) stddev-sans-first:7.11 11:43:11 INFO - PROCESS | 3642 | Values: 124.0 123.0 118.0 119.0 125.0 125.0 118.0 120.0 141.0 123.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 11:43:11 INFO - PROCESS | 3642 | Values: 161.0 160.0 159.0 161.0 165.0 163.0 163.0 159.0 159.0 156.0 11:43:11 INFO - PROCESS | 3642 | 11:43:11 INFO - PROCESS | 3642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.42 (2.2%) stddev-sans-first:1.42 11:43:11 INFO - PROCESS | 3642 | Values: 62.0 65.0 64.0 64.0 63.0 62.0 62.0 63.0 66.0 62.0 11:43:11 INFO - PROCESS | 3642 | -------- Summary: end -------- 11:43:11 INFO - PROCESS | 3642 | 11:43:12 INFO - TEST-INFO | 3642: exit 0 11:43:12 INFO - TEST-OK | kraken | took 62148ms 11:43:12 INFO - SUITE-END | took 1178s 11:43:12 INFO - Completed test suite (00:19:38) 11:43:12 INFO - javascript benchmark 11:43:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.1900505868475, 3124.0627811656495, 3148.952765708514, 3163.873445062198, 3179.618445786506, 5279.894402111955, 5332.093544097503, 5347.786088556453, 5406.513413792758, 5423.322084739408, 5334.679919204841, 5334.759935802888, 5424.945750542493, 5499.532539734128, 5519.69641669708, 4799.064182484417, 4827.927581086269, 4977.601791856661, 5039.924401133986, 5099.59203263738, 4977.776000079987, 5018.222175562793, 5027.773750181233, 5040.117979353617, 5043.0, 4831.975840120795, 4891.339669144655, 4923.4091908970795, 4952.059108769322, 4956.578690811285, 4968.453470118284, 4981.178105612569, 4982.153033984195, 4984.800607975677, 5010.223415370623, 4801.0, 4936.925946110811, 4953.5541801237705, 4973.776180071869, 5004.074246264453, 5289.233061206103, 5323.228131920889, 5340.866478338034, 5342.225377320306, 5371.274877891474, 5701.201831743518, 5857.970710146465, 5866.0, 5867.647941123503, 5878.294604647427, 5700.8859822803315, 5774.595778295521, 5828.125781132821, 5875.764969401219, 5886.0, 5454.863628409282, 5517.586181036439, 5517.862053448696, 5521.199426083195, 5522.006038912994, 6033.219951833536, 6041.9810946063435, 6044.375675702444, 6084.0265557511475, 6090.543209259324, 5641.52047075995, 5693.772249109989, 5785.218995435563, 5836.4747172753805, 5840.3575606683235, 5695.601307908407, 5732.426757324318, 5767.509761670221, 5767.682777447197, 5775.797847075416, 5736.713164341766, 5739.397363276879, 5744.597878148489, 5746.712664366849, 5751.482366587027, 5732.914006289909, 5769.423057694197, 5776.45123713255, 5781.508571771363, 5786.247787787561, 4375.649948004152, 4397.362382454527, 4404.6035856772405, 4407.537208593116, 4412.205802955499, 3932.0366510204612, 3945.467361906163, 3962.0689138052535, 3970.285348637215, 3990.4213888985932, 5471.398146203915, 5474.343078830566, 5476.096444086681, 5484.122540393518, 5485.286912701324, 5745.8563535911935, 5813.040848260074, 5822.446867547576, 5835.649861008353, 5907.852303692442, 5504.4770746778995, 5516.0, 5533.667979921218, 5536.529395001389, 5598.552115830806, 5050.368703912011, 5050.3939527256225, 5053.343065401475, 5065.265536497261, 5097.311862898536, 5902.61632993854, 5907.793227237026, 5914.76340946366, 6088.512918966472, 6095.085737139376, 5804.158397032491, 5805.854853628524, 5860.648361098348, 5864.9413505864395, 5866.472017518444, 5957.6127551709, 5965.313988891333, 5973.820785376446, 5982.58121931478, 5983.282006159115, 5588.273524441796, 5646.915296270641, 5657.4908258256955, 5660.320761508646, 5708.229389032427, 5842.737076831468, 5856.853578660568, 5913.142594323885, 5943.227380440515, 5964.880702385841, 5683.8863222736145, 5733.627314224562, 5735.54115670737, 5739.9139012914, 5744.42555744439, 5491.643043202179, 5574.498295153456, 5744.770209191585, 5748.5688573358, 5758.683272420057, 5515.172724091419, 5556.972215138899, 5567.248421463212, 5570.053090974625, 5618.353889302783, 5691.373948865705, 5750.30996280449, 5753.712314384347, 5759.337676167294, 5759.424057594375, 5452.127659574449, 5500.1749737539685, 5577.163425486209, 5577.972110139423, 5613.859653508532], "value": 5357.020298175923, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.6341541413497, 608.9634621922685, 618.7401291457587, 625.9999999999999, 638.8466767975685, 31226.375472490567, 43592.0, 44471.77764111183, 44478.55521444784, 44596.77701611487, 42939.57060429403, 43510.782446087724, 43549.78225108878, 43604.345934811005, 43626.78186609071, 8519.74440766778, 8676.65293388267, 8691.869621955675, 8698.826023479527, 8700.129987001312, 8624.137586241388, 8674.696385626505, 8753.47479151253, 8768.868466973001, 8769.736907892773, 8715.215630593246, 8799.428037177595, 8811.95594022029, 8812.515311657857, 8813.338999575026, 8730.650773969033, 8770.912290877073, 8781.604827782734, 8783.12168783123, 8789.505784016732, 8666.696665616737, 8741.0, 8753.7811554711, 8755.737327880173, 8758.781030474289, 41212.38181427281, 41735.0, 41743.37384939229, 41744.582554174674, 41751.791241043604, 3493.266414053052, 3575.4458059000635, 3618.3486972344967, 3744.3821769408014, 4012.3981402789523, 31709.524357134662, 31959.680403195904, 32262.838685806655, 32315.353692926245, 33439.832800836084, 3904.7071469639604, 4021.537523184842, 4040.8585699500377, 4087.7547347159266, 4133.441985332001, 294804.0, 296140.5192974043, 296432.0, 296594.0, 296944.0, 54887.45112548823, 54909.0, 54961.450385496435, 55202.72398637981, 55336.72331638396, 59145.0, 59161.70419147877, 59688.10467842986, 59751.0, 59791.40208597858, 13350.465981360638, 13447.596572102853, 13451.932740336431, 13469.057165998285, 13480.191188528719, 9913.80172396548, 9918.40489570628, 9919.107280344804, 9924.900750992541, 9968.352057116264, 14695.853041469449, 16051.197440127948, 16285.755713664304, 16350.427735029454, 16462.92990955584, 5579.107342825209, 6510.121133646991, 6596.835079122964, 6797.524173307821, 6877.423739655451, 939.4832841937044, 1027.6916924922493, 1029.459533744775, 1078.8597482327405, 1084.159776173456, 32034.623380777357, 32494.050356978656, 32604.836975815444, 32893.67106328954, 32897.83551082229, 1171.3674615707423, 1180.2505409065134, 1190.4642910690225, 1229.8647148813623, 1230.39095647655, 16521.33914643425, 16631.251593678313, 16813.991160530408, 17007.319707211573, 17070.48788536346, 507426.0, 510831.0, 510980.0, 511038.0, 512359.0, 57146.0, 57432.0, 57438.7128064357, 57462.7126864363, 57499.13751293734, 1232.2914324263404, 1307.1176955554963, 1365.5357178559339, 1366.5285476510587, 1376.5457399058487, 32510.0, 33606.0, 33705.66294337124, 33835.661643384236, 34210.48684269788, 50236.49763502318, 50551.49448505468, 50748.23877641912, 50752.746236268584, 50761.74619126881, 396036.0, 398802.0, 399245.0, 399319.0, 400541.0, 32537.511937320487, 41068.794656026526, 41618.0, 44269.778651106535, 44789.0, 48281.0, 48443.51556484531, 48775.26837097517, 49582.752086239336, 49661.75169124276, 39045.6095439042, 41147.1770564593, 41202.587974121074, 43442.78278608587, 44968.55031449644, 41541.79229103835, 41680.791596041825, 41933.58066419297, 42315.5768442324, 42619.0, 40605.18789624132, 41410.37884431676, 41851.372229415974, 42066.0, 42360.1527969445, 35819.462708058876, 37484.0, 38077.61922380741, 38239.61760382361, 38248.808755956044, 28564.857175713987, 28862.567061493675, 28983.275418114717, 29037.419251615273, 29094.854525727234], "value": 19747.012440446444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3644305118083, 391.40311025685816, 394.77103280097526, 394.91311911379495, 416.5792549524979, 14235.71528569428, 16622.418215362464, 18285.725714114284, 19689.901550492265, 19830.70253946192, 14723.411063557473, 14732.33704483298, 17624.735628965576, 17978.460646180603, 18042.5489362766, 5455.427180146087, 5637.041702910495, 5646.26598542191, 5661.433856614347, 5678.290213723285, 4001.399790031504, 5449.509544141027, 5658.264425624684, 5658.688772117532, 5664.688442135681, 4600.332951721998, 6259.655718935457, 6260.843478913018, 6349.492040636761, 6361.713722882459, 6256.593321434115, 6310.558260921737, 6331.2719037310835, 6338.08097825815, 6348.682565871688, 5509.449055094458, 5631.2960879890015, 5639.68981706006, 5643.943560564424, 5661.745221465044, 21973.450663733376, 22315.218967336066, 22867.085316587316, 23340.2997910063, 23370.883145584332, 2321.0947730385165, 2327.790498855094, 2351.4882301091952, 2377.9881100594384, 2395.6286775549816, 13162.0, 14095.436182552789, 14133.929330353283, 14647.70704585913, 14709.485168019175, 1865.7481240032557, 1928.9903550482297, 1950.5123719070232, 1965.4791480257743, 2052.056054215063, 78921.0, 79151.0, 80504.0, 80649.19350806533, 81099.5945020277, 10366.378017318984, 10519.684409467729, 10597.364158150536, 10670.466476676134, 10873.782524349468, 14801.851981480262, 15007.924960375129, 15028.699426011419, 15051.0, 15052.54842354731, 6782.253952065269, 6812.659367031629, 7022.6488675566015, 7098.290170982964, 7282.781516554512, 6772.390484856386, 6800.965995169992, 6807.0810440589885, 6948.722051117999, 7014.754483593049, 6528.902066469007, 6540.0, 6566.507511936624, 6590.835229119214, 6790.456763458911, 1744.9389271375694, 1757.4991127528592, 1894.8966647021796, 1917.5014496230801, 1926.2776458827939, 877.5129802959291, 940.0, 1032.8863824979246, 1097.2154909239932, 1158.1834806461425, 18653.253869845325, 18670.919298315624, 19060.237590496225, 19308.32420865263, 19755.0, 989.9851502227473, 1028.3521381529588, 1034.5603118674533, 1037.6938803053117, 1072.2172813845937, 10786.838197427045, 11269.154813388865, 11278.492467838967, 11286.548538058385, 11287.887121128848, 467924.0, 475412.0, 495801.0, 496249.0, 496525.0, 58572.414275856696, 79620.6018969913, 100840.49579752202, 103257.0, 103738.48130759299, 985.7190700650424, 1022.3814592171777, 1040.0691381213921, 1040.0743338428804, 1048.7902419516126, 17305.39431119905, 17455.738163927297, 17770.200340984946, 17773.911130444267, 17991.190396432452, 42016.15967680691, 42334.57665423306, 42605.36091958685, 43497.13005739804, 43792.78103609462, 60194.69902650459, 60516.69741651264, 60879.391206089145, 61234.69382653058, 63271.05093423694, 6869.175698916162, 7345.3021962913435, 7495.587742674205, 7639.0, 7675.884861726967, 10053.899461005296, 13219.272939988394, 13389.263590502616, 13423.597292081253, 13581.11722738019, 11591.24656897299, 11798.705032374259, 11949.522019119486, 12003.699907502032, 12123.575674851338, 11427.657170284905, 11659.883401166218, 11665.125115616192, 11759.294442333487, 11862.562420809489, 11893.345865977455, 11987.0, 12049.156559040783, 12160.087993400353, 12200.572979945659, 7537.736179233701, 7641.923580764121, 7659.1192012917, 7748.496347737379, 7805.375569954276, 9313.44119352841, 11930.164888458072, 11973.161878668758, 12097.697557561132, 12136.696582585506], "value": 9216.196168621347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.4016859684082, 1507.1559926441191, 1529.6328881068541, 1707.6840784454878, 1832.6701193785123, 8359.122292159327, 8703.56482175891, 8709.869351959718, 8897.733068007954, 8924.55377231139, 8171.509709417439, 8300.50196988181, 8306.08633050364, 8350.95824520878, 8362.16378362165, 1988.4034789563145, 2047.1299697628522, 2064.225915281769, 2284.79436850683, 2308.4344335637793, 2200.3508964855405, 2267.455810605459, 2277.4761804784907, 2278.4873403484166, 2289.69089172962, 2190.200576789476, 2213.269621025058, 2223.844330896838, 2226.3432287475152, 2293.4037150340946, 1952.0142328124348, 2210.2706106984656, 2285.211601997308, 2300.1604414388794, 2305.7463678995296, 2098.748150221968, 2115.471132216946, 2115.947101322464, 2117.396541985542, 2126.755423126345, 8652.437591556529, 8665.090165532654, 8694.347923905732, 8701.129887011311, 8708.216260536583, 5057.924131138036, 5170.6122040847085, 5172.2241663750365, 5178.042062218502, 5189.117849965515, 3121.7190452859127, 3208.0856955767495, 3251.6260630027614, 3252.235724604716, 3258.706716395512, 1049.632628579991, 1067.4502631144967, 1073.3667136389568, 1075.1022895881947, 1109.051760744568, 12518.624441266777, 12722.173058751245, 12749.808752868714, 12788.0, 12799.5520156795, 4523.683342166017, 4633.745144017044, 4639.443266807937, 4643.582077612963, 4643.883902902387, 10884.782304353868, 10902.781944361226, 10904.400257985886, 10930.672079837617, 10943.781124377469, 5234.685918844805, 5247.921281180786, 5249.133892907704, 5251.737413129328, 5266.1574148136115, 4225.239456897726, 4567.132244873464, 4633.72197668141, 4711.882202944954, 4740.502247264057, 3980.24375368679, 3991.221711766236, 4046.1503084352025, 4082.040720430696, 4160.625543701081, 1236.412703965627, 1238.3746208164819, 1255.5856567332758, 1267.5056727876135, 1290.9289989050692, 806.4113197365956, 877.2411863737948, 940.5626383731598, 973.3867663372031, 1012.6658202793061, 6084.39156084388, 6130.976777663361, 6173.41352571505, 6248.750049997949, 6307.3377295383325, 437.58210908582225, 444.83541089796984, 449.34171438842253, 456.2494696224692, 471.5311803731352, 4077.429159917614, 4095.6723462123555, 4299.269124248885, 4310.245707001262, 4339.1104823511105, 11215.383153926612, 11442.427878606037, 11528.481218345194, 11537.19239653233, 11579.76840463186, 11144.275622084539, 11326.263792853439, 11369.2609980351, 11414.94292528532, 11432.657020289405, 8202.507849529047, 8453.365997550209, 8460.746177614681, 8476.152384761475, 8478.533680647624, 6045.21412216409, 6097.237845269341, 6226.972549529277, 6309.400606942333, 6394.23269207698, 10174.694759157237, 10324.690259292232, 10458.581656733646, 10606.416647084485, 10621.468926553487, 10540.420276884844, 10642.255042146975, 10762.246642734934, 10766.246362754531, 10771.784564308826, 7169.175544812205, 7738.92261077382, 7803.258690424401, 8003.879941800994, 8050.758477245692, 8829.38194326391, 8876.467411955304, 8881.42270752399, 8892.15524525169, 8950.373473856767, 7643.7324693635455, 7859.056913170456, 7871.173526779835, 7919.247671471201, 7922.0, 7411.370033546993, 7723.0, 7749.0, 7832.177621349676, 7976.601169941596, 6945.0971373721095, 7122.7507037253445, 7124.430045596237, 7146.678399471933, 7154.713811447484, 5000.524950129732, 5127.128388173945, 5179.948200517946, 5320.813771517978, 5358.624896257381, 5262.6316157870115, 5377.489138531833, 5408.323959505062, 5456.127019676833, 5610.775568977195], "value": 4549.5549678004645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.31996966733846, 320.64888946603475, 322.16077119104716, 322.5645378738703, 331.0895038643729, 5080.822171224008, 5159.303494028305, 5233.398159211692, 5254.632175747694, 5261.421243663194, 5199.662021968569, 5208.973955130219, 5211.80128570429, 5214.348206474191, 5222.0, 4067.491563554556, 4074.5314288856716, 4080.7959602019855, 4104.733192342503, 4151.40171034151, 3827.8468861245656, 3890.1441682829873, 4073.348264277716, 4101.2207680540605, 4114.156597897424, 4025.838966441339, 4036.919261614766, 4054.898627534306, 4067.532233793122, 4077.531083925342, 4026.11425486394, 4046.693384770682, 4046.898827529306, 4068.837246510136, 4089.672826173899, 3550.3076900004507, 3623.5108260384773, 3624.9637503625154, 3637.1634524059614, 3641.635836416364, 4928.876778080541, 4995.325631039799, 5008.24876268559, 5068.189089745623, 5087.643864929457, 4563.315502674625, 4599.471060828014, 4599.701019433726, 4605.83879564217, 4606.355110284563, 5230.8169214077325, 5378.139497680391, 5424.593155513313, 5455.0, 5461.924468701907, 3880.6313400227214, 3893.201893611803, 3910.1397692507603, 3914.178022615254, 3919.118198405336, 5655.349634792011, 5704.942950570483, 5715.342735585377, 5736.651886806597, 5751.568632352591, 3842.7502212356108, 3950.802459876995, 3964.2269757397607, 3992.0219546211365, 3995.700322475826, 3983.183447393277, 3998.6204759357975, 4011.1777085697363, 4033.1127152026506, 4041.474608300902, 4641.744704041243, 4665.4168228971375, 4672.462666793363, 4673.481118636457, 4680.765961701902, 5263.763130659129, 5487.176923461513, 5511.724413779295, 5536.501714845684, 5574.637648552831, 1290.922080063139, 1327.2832670357898, 1336.6658335416146, 1346.212465707572, 1363.4137320951888, 864.3646919514152, 890.6481939633937, 894.9507777072323, 896.0815164456354, 898.034612791252, 4736.176572019797, 4750.477447480775, 4772.522747725269, 4781.545753153515, 4827.275908613736, 4758.476567577563, 5018.372703412074, 5025.492352294297, 5151.716655583904, 5153.819616313411, 4630.58324750774, 4632.401821371622, 4635.629149668019, 4717.787699553528, 4720.480747117883, 2636.9604455933177, 2662.3211081174177, 2662.8668566571596, 2711.25440503863, 2714.24001279642, 4827.131116399011, 5054.393472783289, 5143.228515722597, 5166.560842328444, 5250.553702935217, 5015.874603134878, 5020.748962551857, 5038.445770965191, 5057.216131499624, 5111.028904508132, 5102.719350435687, 5117.948820511747, 5133.897322053538, 5134.409542902614, 5148.704828909501, 4778.522147785333, 4971.577415919687, 4999.0, 5000.324956131021, 5003.974980125076, 4857.692596016864, 4883.755812209304, 4903.190973489477, 4969.279454479008, 4999.200127979506, 5076.619253556072, 5076.949230507647, 5135.589152867837, 5149.0, 5150.97424512875, 3358.4290670586547, 3623.8550457981387, 3645.908852278714, 3662.1210909381025, 3667.651573100551, 4938.43208031081, 4967.441767489818, 4974.562464392494, 4991.5258050485145, 5006.974965125297, 4834.492378300369, 4871.805127794849, 4890.168671325812, 4907.386576677915, 4916.532929371704, 4889.555222388805, 4906.607471402351, 5012.248162775612, 5275.261463395051, 5332.173513105475, 5372.677639341496, 5373.623846330719, 5374.704391258519, 5393.8112166074, 5415.377231618414, 5452.345718513804, 5470.480304371078, 5515.889682206253, 5519.69641669712, 5534.142207957773, 5165.535101840853, 5365.248865158803, 5376.973115134556, 5429.511343979061, 5453.318335208099], "value": 3979.0188447547375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.8802473641322, 853.7652145659939, 863.1411745313412, 869.4609342207832, 888.6045709659201, 14859.182744949037, 15458.1498017609, 15619.765703514457, 15641.217939103042, 15643.139627320521, 14002.439902403892, 14533.563993080197, 14538.781918271234, 14540.418383264683, 14557.854421455782, 685.8662560800645, 799.3684988858795, 820.9302209312216, 828.9295409890167, 829.8589239829244, 834.5451728807815, 834.56185502611, 836.9707060252892, 837.4431003382743, 837.5226121110969, 864.4813112132701, 864.5417928497906, 865.9740207793776, 866.0733015673201, 866.077627326898, 709.8083517450285, 842.540815255684, 852.7868032991752, 861.573521107056, 862.6463150108489, 627.0312367392389, 630.3664816859027, 630.6468377708497, 631.5326658272845, 631.782035197856, 14134.717305653829, 14231.647993440607, 14238.216898070603, 14250.073745206528, 14256.35846386915, 13812.37844297009, 13921.443142274296, 14042.087264327785, 14066.226357550433, 14278.357473913698, 11861.762764744743, 11939.104567157498, 11972.64082077539, 12004.759904801942, 12014.159008869383, 4498.302763071729, 4501.549845015505, 4590.081983603292, 4605.470370907322, 4611.815527378901, 59274.0, 59472.702636486974, 59477.40522594805, 59985.70007149936, 60462.093068604445, 11324.207305488702, 11335.149863760085, 11434.199606027498, 11477.311361318347, 11505.194636375541, 20512.58974820525, 20570.58858822815, 20575.4856128595, 20637.380878573666, 20642.690359644617, 7968.163342849033, 8022.679092836222, 8045.115037345888, 8091.716789912325, 8125.512469251864, 4313.6980411370905, 4407.911841763147, 4433.423654924839, 4491.595756381941, 4632.675712700146, 3318.469044952796, 3363.5963684358035, 3386.508956201337, 3410.334984677964, 3422.760406771552, 614.757170917485, 617.305531277313, 621.6518749500204, 631.210986267166, 642.0337392224671, 541.0450554770832, 626.9529785266124, 628.6887990444759, 695.4957655699577, 751.2149803455402, 9551.808963820684, 9690.567086822975, 9770.658026969022, 9776.120149186607, 9917.157041651397, 710.6517806274888, 719.1801346465035, 726.2700985509529, 728.9198188199293, 750.8798592225218, 4357.694961352675, 4599.862004139881, 4659.534046595313, 4764.2615394613895, 4859.07677541266, 57856.0, 59467.40532594619, 60213.39786602165, 62249.0, 67800.3219967794, 60711.08933366003, 61263.38736612577, 61476.0, 61796.0, 62230.68884655638, 49909.50090499121, 50185.74907125441, 50366.748166258934, 54804.451955480734, 55993.720031399585, 10050.19598432109, 10181.898181018096, 10221.185458560833, 10262.743431414274, 10494.160467162761, 36829.63170368369, 37432.625673742914, 37528.0, 37867.62132378641, 38462.42306365351, 45471.77264113658, 48301.75849120732, 48601.513984861114, 48920.75539622279, 50046.749766250934, 12586.322343370719, 12816.743665126458, 12848.42182101789, 12926.095173337777, 12947.28789916526, 13993.720125597634, 14256.786148207993, 14525.709485810014, 14605.488807891672, 14664.486742963945, 13158.60524184276, 13495.527656531975, 13592.66018349549, 13807.309634518033, 13920.234387108807, 13069.467124088225, 13262.734745304846, 13316.0, 13537.390817413043, 13708.177509349072, 12976.351182441029, 13092.214467132002, 13112.409941552462, 13112.409941552462, 13135.73728525405, 10838.783224335626, 10997.230193886351, 11231.0, 11380.089592832388, 11633.243839150427, 10808.601829010055, 11086.946740059682, 11474.311541307214, 11479.139064570023, 11495.942520287344], "value": 7019.012925407602, "unit": "score"}], "name": "dromaeo_css", "value": 7060.587265038103, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 113.0, 110.0, 112.0, 110.0, 110.0, 109.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 127.0, 185.0, 126.0, 133.0, 155.0, 128.0, 159.0, 133.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 117.0, 74.0, 78.0, 75.0, 73.0, 96.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 115.0, 83.0, 83.0, 84.0, 115.0, 84.0, 84.0, 130.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "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, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 52.0, 52.0, 54.0, 52.0, 53.0, 54.0, 54.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 80.0, 79.0, 85.0, 79.0, 80.0, 114.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 118.0, 119.0, 125.0, 125.0, 118.0, 120.0, 141.0, 123.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 165.0, 163.0, 163.0, 159.0, 159.0, 156.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 64.0, 63.0, 62.0, 62.0, 63.0, 66.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1491.1, "alertThreshold": 2.0}]} 11:43:12 INFO - Return code: 0 11:43:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:12 ERROR - # TBPL SUCCESS # 11:43:12 INFO - Running post-action listener: _resource_record_post_action 11:43:12 INFO - ##### 11:43:12 INFO - ##### Finished run-tests step (success) 11:43:12 INFO - ##### 11:43:12 INFO - Running post-run listener: _resource_record_post_run 11:43:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 416747520; Read time: 1340; Write time: 500512 11:43:12 INFO - TinderboxPrint: CPU usage
13.3% 11:43:12 INFO - TinderboxPrint: I/O read bytes / time
7,806,976 / 1,340 11:43:12 INFO - TinderboxPrint: I/O write bytes / time
416,747,520 / 500,512 11:43:12 INFO - TinderboxPrint: CPU idle
8,276.5 (86.7%) 11:43:12 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 11:43:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:43:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 54882304; Read time: 100; Write time: 24408 11:43:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 361865216; Read time: 1196; Write time: 476104 11:43:13 INFO - Running post-run listener: _upload_blobber_files 11:43:13 INFO - Blob upload gear active. 11:43:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:13 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 11:43:13 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'] 11:43:13 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 11:43:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:14 INFO - (blobuploader) - INFO - Done attempting. 11:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:18 INFO - (blobuploader) - INFO - Done attempting. 11:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:19 INFO - (blobuploader) - INFO - Done attempting. 11:43:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:19 INFO - Return code: 0 11:43:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f3d4adf36ee78db4231b43b1a52c3d60ef57e2f1fc67dc2fd551a40888a6b0389afe20b8396d8817db05e3d41c98ce81e70e77617f972e21c42dd99af43d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a0c88d90b5116175f2978f65a87665ab9c9eaf0f72691a38b75c1284170c5257d6b87e29b3f57d66d61a11da5f4711616dd46f64b4c49357f5657fe80b1770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40ffde4138e9e527466de8047acac2253c7617d7308603bd94ebc4ef1f6715b8defd0489a4f050e8d6bbb071c57bb0882ed863e024e81780811c6315393f31e4"} 11:43:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:19 INFO - Contents: 11:43:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f3d4adf36ee78db4231b43b1a52c3d60ef57e2f1fc67dc2fd551a40888a6b0389afe20b8396d8817db05e3d41c98ce81e70e77617f972e21c42dd99af43d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a0c88d90b5116175f2978f65a87665ab9c9eaf0f72691a38b75c1284170c5257d6b87e29b3f57d66d61a11da5f4711616dd46f64b4c49357f5657fe80b1770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40ffde4138e9e527466de8047acac2253c7617d7308603bd94ebc4ef1f6715b8defd0489a4f050e8d6bbb071c57bb0882ed863e024e81780811c6315393f31e4"} 11:43:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:19 INFO - Copying logs to upload dir... 11:43:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.763425 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-31 11:43:19.558848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 11:43:19.562930) ========= 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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 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/9f3d4adf36ee78db4231b43b1a52c3d60ef57e2f1fc67dc2fd551a40888a6b0389afe20b8396d8817db05e3d41c98ce81e70e77617f972e21c42dd99af43d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a0c88d90b5116175f2978f65a87665ab9c9eaf0f72691a38b75c1284170c5257d6b87e29b3f57d66d61a11da5f4711616dd46f64b4c49357f5657fe80b1770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40ffde4138e9e527466de8047acac2253c7617d7308603bd94ebc4ef1f6715b8defd0489a4f050e8d6bbb071c57bb0882ed863e024e81780811c6315393f31e4"} build_url:https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/NDlI9gs_TaGCbijQYCCDcw/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/9f3d4adf36ee78db4231b43b1a52c3d60ef57e2f1fc67dc2fd551a40888a6b0389afe20b8396d8817db05e3d41c98ce81e70e77617f972e21c42dd99af43d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a0c88d90b5116175f2978f65a87665ab9c9eaf0f72691a38b75c1284170c5257d6b87e29b3f57d66d61a11da5f4711616dd46f64b4c49357f5657fe80b1770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40ffde4138e9e527466de8047acac2253c7617d7308603bd94ebc4ef1f6715b8defd0489a4f050e8d6bbb071c57bb0882ed863e024e81780811c6315393f31e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 11:43:19.588506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:43:19.588827) ========= 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=920470bf432669ad7e3a5387000001ca-1464718886.866443-21362934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:43:19.676762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 11:43:19.677655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 11:43:19.678260) ========= ========= Total master_lag: 0.19 =========