builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1463500169.88 results: success (0) buildid: 20160517053004 builduid: 09c61dcf16994e72a2881b6f9dec81fc revision: 6e2add233b54766d44568f81aa207c624bbe4437 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:29.877199) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:29.877768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:29.878043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:29.893703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:29.893963) ========= 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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 08:49:29-- 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% 46.4M=0s 2016-05-17 08:49:30 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.014147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.014458) ========= 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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.063449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.063815) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e2add233b54766d44568f81aa207c624bbe4437 --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 6e2add233b54766d44568f81aa207c624bbe4437 --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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 08:49:30,151 truncating revision to first 12 chars 2016-05-17 08:49:30,151 Setting DEBUG logging. 2016-05-17 08:49:30,151 attempt 1/10 2016-05-17 08:49:30,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e2add233b54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 08:49:30,464 unpacking tar archive at: fx-team-6e2add233b54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.595240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.672887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.673188) ========= script_repo_revision: 6e2add233b54766d44568f81aa207c624bbe4437 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.673579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.673858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 08:49:30.681414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-17 08:49:30.681690) ========= /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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:30 INFO - MultiFileLogger online at 20160517 08:49:30 in /builds/slave/test 08:49:30 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 08:49:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:30 INFO - {'append_to_log': False, 08:49:30 INFO - 'base_work_dir': '/builds/slave/test', 08:49:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:49:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:30 INFO - 'branch': 'Fx-Team', 08:49:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:30 INFO - 'config_files': ('talos/linux_config.py',), 08:49:30 INFO - 'default_actions': ('clobber', 08:49:30 INFO - 'read-buildbot-config', 08:49:30 INFO - 'download-and-extract', 08:49:30 INFO - 'populate-webroot', 08:49:30 INFO - 'create-virtualenv', 08:49:30 INFO - 'install', 08:49:30 INFO - 'run-tests'), 08:49:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:30 INFO - 'download_minidump_stackwalk': True, 08:49:30 INFO - 'download_symbols': 'ondemand', 08:49:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:30 INFO - 'installer_path': 'installer.exe', 08:49:30 INFO - 'log_level': 'info', 08:49:30 INFO - 'log_name': 'talos', 08:49:30 INFO - 'log_to_console': True, 08:49:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:30 INFO - 'opt_config_files': (), 08:49:30 INFO - 'pip_index': False, 08:49:30 INFO - 'sps_profile': False, 08:49:30 INFO - 'sps_profile_interval': 0, 08:49:30 INFO - 'suite': 'dromaeojs', 08:49:30 INFO - 'system_bits': '32', 08:49:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:30 INFO - 'title': 'talos-linux64-ix-007', 08:49:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:30 INFO - 'use_talos_json': True, 08:49:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:30 INFO - 'work_dir': 'build'} 08:49:30 INFO - ##### 08:49:30 INFO - ##### Running clobber step. 08:49:30 INFO - ##### 08:49:30 INFO - Running pre-action listener: _resource_record_pre_action 08:49:30 INFO - Running main action method: clobber 08:49:30 INFO - rmtree: /builds/slave/test/build 08:49:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - ##### 08:49:31 INFO - ##### Finished clobber step (success) 08:49:31 INFO - ##### 08:49:31 INFO - ##### 08:49:31 INFO - ##### Running read-buildbot-config step. 08:49:31 INFO - ##### 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: read_buildbot_config 08:49:31 INFO - Using buildbot properties: 08:49:31 INFO - { 08:49:31 INFO - "project": "", 08:49:31 INFO - "product": "firefox", 08:49:31 INFO - "script_repo_revision": "production", 08:49:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:49:31 INFO - "repository": "", 08:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:49:31 INFO - "buildid": "20160517053004", 08:49:31 INFO - "pgo_build": "True", 08:49:31 INFO - "basedir": "/builds/slave/test", 08:49:31 INFO - "buildnumber": 1161, 08:49:31 INFO - "slavename": "talos-linux64-ix-007", 08:49:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:49:31 INFO - "platform": "ubuntu64_hw", 08:49:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:49:31 INFO - "branch": "fx-team", 08:49:31 INFO - "repo_path": "integration/fx-team", 08:49:31 INFO - "revision": "6e2add233b54766d44568f81aa207c624bbe4437", 08:49:31 INFO - "stage_platform": "linux64-pgo", 08:49:31 INFO - "builduid": "09c61dcf16994e72a2881b6f9dec81fc", 08:49:31 INFO - "slavebuilddir": "test" 08:49:31 INFO - } 08:49:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - ##### 08:49:31 INFO - ##### Finished read-buildbot-config step (success) 08:49:31 INFO - ##### 08:49:31 INFO - ##### 08:49:31 INFO - ##### Running download-and-extract step. 08:49:31 INFO - ##### 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: download_and_extract 08:49:31 INFO - mkdir: /builds/slave/test/build/tests 08:49:31 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')]} 08:49:31 INFO - https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:32 INFO - Downloaded 1361 bytes. 08:49:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:32 INFO - Using the following test package requirements: 08:49:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:49:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:49:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'jsshell-linux-x86_64.zip'], 08:49:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:49:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:49:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:49:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:49:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:49:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:49: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')]} 08:49:32 INFO - https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:33 INFO - Downloaded 24023342 bytes. 08:49:33 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'] 08:49:33 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 08:49:34 INFO - Return code: 0 08:49:34 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 08:49:34 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')]} 08:49:34 INFO - https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:35 INFO - Downloaded 24023342 bytes. 08:49:35 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'] 08:49:35 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 08:49:37 INFO - Return code: 0 08:49: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')]} 08:49:37 INFO - https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:38 INFO - Downloaded 10840194 bytes. 08:49:38 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'] 08:49:38 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 08:49:38 INFO - Return code: 0 08:49: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')]} 08:49:38 INFO - https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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 08:49:39 INFO - Downloaded 58426703 bytes. 08:49:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:39 INFO - mkdir: /builds/slave/test/properties 08:49:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:39 INFO - Contents: 08:49:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - Running post-action listener: set_extra_try_arguments 08:49:40 INFO - ##### 08:49:40 INFO - ##### Finished download-and-extract step (success) 08:49:40 INFO - ##### 08:49:40 INFO - ##### 08:49:40 INFO - ##### Running populate-webroot step. 08:49:40 INFO - ##### 08:49:40 INFO - Running pre-action listener: _resource_record_pre_action 08:49:40 INFO - Running main action method: populate_webroot 08:49:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:40 INFO - '--tppagecycles', 08:49:40 INFO - '7'], 08:49:40 INFO - 'tests': ['tsvgm']}}, 08:49:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['damp', 'tps']}, 08:49:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'tests': ['damp', 'tps']}, 08:49:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['dromaeo_dom']}, 08:49:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['a11yr', 08:49:40 INFO - 'ts_paint', 08:49:40 INFO - 'tpaint', 08:49:40 INFO - 'sessionrestore', 08:49:40 INFO - 'sessionrestore_no_auto_restore', 08:49:40 INFO - 'tabpaint']}, 08:49:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['tsvgx', 08:49:40 INFO - 'tsvgr_opacity', 08:49:40 INFO - 'tart', 08:49:40 INFO - 'tscrollx', 08:49:40 INFO - 'cart']}, 08:49:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:40 INFO - 'tsvgr_opacity', 08:49:40 INFO - 'tart', 08:49:40 INFO - 'tscrollx', 08:49:40 INFO - 'cart']}, 08:49:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'talos_options': ['--disable-e10s'], 08:49:40 INFO - 'tests': ['tp5o']}, 08:49:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'tests': ['tp5o']}, 08:49:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'talos_options': ['--disable-e10s', 08:49:40 INFO - '--xperf_path', 08:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:40 INFO - 'tests': ['tp5n']}, 08:49:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:40 INFO - 'talos_options': ['--xperf_path', 08:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:40 INFO - 'tests': ['tp5n']}}, 08:49:40 INFO - 'talos.zip': {'path': '', 08:49:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - ##### 08:49:40 INFO - ##### Finished populate-webroot step (success) 08:49:40 INFO - ##### 08:49:40 INFO - ##### 08:49:40 INFO - ##### Running create-virtualenv step. 08:49:40 INFO - ##### 08:49:40 INFO - Running pre-action listener: _resource_record_pre_action 08:49:40 INFO - Running main action method: create_virtualenv 08:49:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:40 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 08:49:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:40 INFO - Using real prefix '/usr' 08:49:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:42 INFO - Installing pip.................done. 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'DISPLAY': ':0', 08:49:42 INFO - 'HOME': '/home/cltbld', 08:49:42 INFO - 'LANG': 'en_US.UTF-8', 08:49:42 INFO - 'LANGUAGE': 'en_US:en', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MAIL': '/var/mail/cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SHLVL': '1', 08:49:42 INFO - 'TERM': 'linux', 08:49:42 INFO - 'TMOUT': '86400', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - '_': '/tools/buildbot/bin/python'} 08:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:43 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 08:49:43 INFO - Cleaning up... 08:49:43 INFO - Return code: 0 08:49:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:43 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 08:49:43 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 08:49:43 INFO - Using env: {'DISPLAY': ':0', 08:49:43 INFO - 'HOME': '/home/cltbld', 08:49:43 INFO - 'LANG': 'en_US.UTF-8', 08:49:43 INFO - 'LANGUAGE': 'en_US:en', 08:49:43 INFO - 'LOGNAME': 'cltbld', 08:49:43 INFO - 'MAIL': '/var/mail/cltbld', 08:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:43 INFO - 'MOZ_NO_REMOTE': '1', 08:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:43 INFO - 'NO_EM_RESTART': '1', 08:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:43 INFO - 'PWD': '/builds/slave/test', 08:49:43 INFO - 'SHELL': '/bin/bash', 08:49:43 INFO - 'SHLVL': '1', 08:49:43 INFO - 'TERM': 'linux', 08:49:43 INFO - 'TMOUT': '86400', 08:49:43 INFO - 'USER': 'cltbld', 08:49:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:43 INFO - '_': '/tools/buildbot/bin/python'} 08:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:43 INFO - Downloading/unpacking psutil>=3.1.1 08:49:43 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 08:49:43 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 08:49:43 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 08:49:43 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 08:49:43 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 08:49:43 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 08:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:45 INFO - Installing collected packages: psutil 08:49:45 INFO - Running setup.py install for psutil 08:49:45 INFO - building 'psutil._psutil_linux' extension 08:49:45 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 08:49:45 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 08:49:45 INFO - building 'psutil._psutil_posix' extension 08:49:45 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 08:49:45 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 08:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:45 INFO - Successfully installed psutil 08:49:45 INFO - Cleaning up... 08:49:45 INFO - Return code: 0 08:49:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:45 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 08:49:45 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 08:49:46 INFO - Using env: {'DISPLAY': ':0', 08:49:46 INFO - 'HOME': '/home/cltbld', 08:49:46 INFO - 'LANG': 'en_US.UTF-8', 08:49:46 INFO - 'LANGUAGE': 'en_US:en', 08:49:46 INFO - 'LOGNAME': 'cltbld', 08:49:46 INFO - 'MAIL': '/var/mail/cltbld', 08:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:46 INFO - 'MOZ_NO_REMOTE': '1', 08:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:46 INFO - 'NO_EM_RESTART': '1', 08:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:46 INFO - 'PWD': '/builds/slave/test', 08:49:46 INFO - 'SHELL': '/bin/bash', 08:49:46 INFO - 'SHLVL': '1', 08:49:46 INFO - 'TERM': 'linux', 08:49:46 INFO - 'TMOUT': '86400', 08:49:46 INFO - 'USER': 'cltbld', 08:49:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:46 INFO - '_': '/tools/buildbot/bin/python'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:48 INFO - Installing collected packages: mozsystemmonitor 08:49:48 INFO - Running setup.py install for mozsystemmonitor 08:49:48 INFO - Successfully installed mozsystemmonitor 08:49:48 INFO - Cleaning up... 08:49:48 INFO - Return code: 0 08:49:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:48 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')]} 08:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:48 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')]} 08:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:48 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:48 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 08:49:48 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 08:49:48 INFO - Using env: {'DISPLAY': ':0', 08:49:48 INFO - 'HOME': '/home/cltbld', 08:49:48 INFO - 'LANG': 'en_US.UTF-8', 08:49:48 INFO - 'LANGUAGE': 'en_US:en', 08:49:48 INFO - 'LOGNAME': 'cltbld', 08:49:48 INFO - 'MAIL': '/var/mail/cltbld', 08:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:48 INFO - 'MOZ_NO_REMOTE': '1', 08:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:48 INFO - 'NO_EM_RESTART': '1', 08:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:48 INFO - 'PWD': '/builds/slave/test', 08:49:48 INFO - 'SHELL': '/bin/bash', 08:49:48 INFO - 'SHLVL': '1', 08:49:48 INFO - 'TERM': 'linux', 08:49:48 INFO - 'TMOUT': '86400', 08:49:48 INFO - 'USER': 'cltbld', 08:49:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:48 INFO - '_': '/tools/buildbot/bin/python'} 08:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 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 08:49:51 INFO - Downloading docopt-0.6.1.tar.gz 08:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:51 INFO - Running setup.py install for blobuploader 08:49:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:51 INFO - Running setup.py install for requests 08:49:51 INFO - Running setup.py install for docopt 08:49:51 INFO - Successfully installed blobuploader requests docopt 08:49:51 INFO - Cleaning up... 08:49:51 INFO - Return code: 0 08:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:51 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')]} 08:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:51 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')]} 08:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:51 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:51 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 08:49:51 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 08:49:51 INFO - Using env: {'DISPLAY': ':0', 08:49:51 INFO - 'HOME': '/home/cltbld', 08:49:51 INFO - 'LANG': 'en_US.UTF-8', 08:49:51 INFO - 'LANGUAGE': 'en_US:en', 08:49:51 INFO - 'LOGNAME': 'cltbld', 08:49:51 INFO - 'MAIL': '/var/mail/cltbld', 08:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:51 INFO - 'MOZ_NO_REMOTE': '1', 08:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:51 INFO - 'NO_EM_RESTART': '1', 08:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:51 INFO - 'PWD': '/builds/slave/test', 08:49:51 INFO - 'SHELL': '/bin/bash', 08:49:51 INFO - 'SHLVL': '1', 08:49:51 INFO - 'TERM': 'linux', 08:49:51 INFO - 'TMOUT': '86400', 08:49:51 INFO - 'USER': 'cltbld', 08:49:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:51 INFO - '_': '/tools/buildbot/bin/python'} 08:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:52 INFO - Running setup.py (path:/tmp/pip-uI6SHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:52 INFO - Running setup.py (path:/tmp/pip-7r9X4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:52 INFO - Running setup.py (path:/tmp/pip-a5ms9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:52 INFO - Running setup.py (path:/tmp/pip-bRVWDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:52 INFO - Running setup.py (path:/tmp/pip-uD_bPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:52 INFO - Running setup.py (path:/tmp/pip-qwvd3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:52 INFO - Running setup.py (path:/tmp/pip-sFuBnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:52 INFO - Running setup.py (path:/tmp/pip-sqMg3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:52 INFO - Running setup.py (path:/tmp/pip-JORLJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:52 INFO - Running setup.py (path:/tmp/pip-CwrRhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:52 INFO - Running setup.py (path:/tmp/pip-c6KO3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:52 INFO - Running setup.py (path:/tmp/pip-o1H5q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:52 INFO - Running setup.py (path:/tmp/pip-q_3lTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:53 INFO - Running setup.py (path:/tmp/pip-dWZOlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:53 INFO - Running setup.py (path:/tmp/pip-J0xLKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:53 INFO - Running setup.py (path:/tmp/pip-RzmegE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:53 INFO - Running setup.py (path:/tmp/pip-Iu7B41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:53 INFO - Running setup.py install for manifestparser 08:49:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:53 INFO - Running setup.py install for mozcrash 08:49:53 INFO - Running setup.py install for mozdebug 08:49:53 INFO - Running setup.py install for mozdevice 08:49:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:53 INFO - Running setup.py install for mozfile 08:49:53 INFO - Running setup.py install for mozhttpd 08:49:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:53 INFO - Running setup.py install for mozinfo 08:49:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for mozInstall 08:49:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for mozleak 08:49:54 INFO - Running setup.py install for mozlog 08:49:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for moznetwork 08:49:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for mozprocess 08:49:54 INFO - Running setup.py install for mozprofile 08:49:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for mozrunner 08:49:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:54 INFO - Running setup.py install for mozscreenshot 08:49:54 INFO - Running setup.py install for moztest 08:49:55 INFO - Running setup.py install for mozversion 08:49:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:55 INFO - Cleaning up... 08:49:55 INFO - Return code: 0 08:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:55 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')]} 08:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:55 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')]} 08:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:55 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:55 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 08:49:55 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 08:49:55 INFO - Using env: {'DISPLAY': ':0', 08:49:55 INFO - 'HOME': '/home/cltbld', 08:49:55 INFO - 'LANG': 'en_US.UTF-8', 08:49:55 INFO - 'LANGUAGE': 'en_US:en', 08:49:55 INFO - 'LOGNAME': 'cltbld', 08:49:55 INFO - 'MAIL': '/var/mail/cltbld', 08:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:55 INFO - 'MOZ_NO_REMOTE': '1', 08:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:55 INFO - 'NO_EM_RESTART': '1', 08:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:55 INFO - 'PWD': '/builds/slave/test', 08:49:55 INFO - 'SHELL': '/bin/bash', 08:49:55 INFO - 'SHLVL': '1', 08:49:55 INFO - 'TERM': 'linux', 08:49:55 INFO - 'TMOUT': '86400', 08:49:55 INFO - 'USER': 'cltbld', 08:49:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:55 INFO - '_': '/tools/buildbot/bin/python'} 08:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:55 INFO - Running setup.py (path:/tmp/pip-yirzd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:55 INFO - Running setup.py (path:/tmp/pip-ff3dsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:55 INFO - Running setup.py (path:/tmp/pip-bNjJGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:55 INFO - Running setup.py (path:/tmp/pip-7nThYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:55 INFO - Running setup.py (path:/tmp/pip-n_Difu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:55 INFO - Running setup.py (path:/tmp/pip-wj0ZBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:55 INFO - Running setup.py (path:/tmp/pip-6lcQbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:55 INFO - Running setup.py (path:/tmp/pip-TF51Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:55 INFO - Running setup.py (path:/tmp/pip-omOJkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:55 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)) 08:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:55 INFO - Running setup.py (path:/tmp/pip-b2GEeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:56 INFO - Running setup.py (path:/tmp/pip-ws3fwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:56 INFO - Running setup.py (path:/tmp/pip-mhoQm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:56 INFO - Running setup.py (path:/tmp/pip-d61yBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:56 INFO - Running setup.py (path:/tmp/pip-60MXEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:56 INFO - Running setup.py (path:/tmp/pip-Jz2xFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:56 INFO - Running setup.py (path:/tmp/pip-KxaSNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:56 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)) 08:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:56 INFO - Running setup.py (path:/tmp/pip-svNE3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:56 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)) 08:49:56 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)) 08:49:56 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)) 08:49:56 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)) 08:49:56 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)) 08:49:56 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)) 08:49:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:56 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 08:49:56 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 08:49:56 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 08:49:56 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 08:49:56 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 08:49:56 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 08:49:58 INFO - Downloading blessings-1.6.tar.gz 08:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:58 INFO - Installing collected packages: blessings 08:49:58 INFO - Running setup.py install for blessings 08:49:58 INFO - Successfully installed blessings 08:49:58 INFO - Cleaning up... 08:49:58 INFO - Return code: 0 08:49:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:58 INFO - Reading from file tmpfile_stdout 08:49:58 INFO - Current package versions: 08:49:58 INFO - argparse == 1.2.1 08:49:58 INFO - blessings == 1.6 08:49:58 INFO - blobuploader == 1.2.4 08:49:58 INFO - docopt == 0.6.1 08:49:58 INFO - manifestparser == 1.1 08:49:58 INFO - mozInstall == 1.12 08:49:58 INFO - mozcrash == 0.17 08:49:58 INFO - mozdebug == 0.1 08:49:58 INFO - mozdevice == 0.48 08:49:58 INFO - mozfile == 1.2 08:49:58 INFO - mozhttpd == 0.7 08:49:58 INFO - mozinfo == 0.9 08:49:58 INFO - mozleak == 0.1 08:49:58 INFO - mozlog == 3.2 08:49:58 INFO - moznetwork == 0.27 08:49:58 INFO - mozprocess == 0.22 08:49:58 INFO - mozprofile == 0.28 08:49:58 INFO - mozrunner == 6.11 08:49:58 INFO - mozscreenshot == 0.1 08:49:58 INFO - mozsystemmonitor == 0.3 08:49:58 INFO - moztest == 0.7 08:49:58 INFO - mozversion == 1.4 08:49:58 INFO - psutil == 3.1.1 08:49:58 INFO - requests == 1.2.3 08:49:58 INFO - wsgiref == 0.1.2 08:49:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:58 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49:58 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 08:49:58 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 08:49:58 INFO - Using env: {'DISPLAY': ':0', 08:49:58 INFO - 'HOME': '/home/cltbld', 08:49:58 INFO - 'LANG': 'en_US.UTF-8', 08:49:58 INFO - 'LANGUAGE': 'en_US:en', 08:49:58 INFO - 'LOGNAME': 'cltbld', 08:49:58 INFO - 'MAIL': '/var/mail/cltbld', 08:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:58 INFO - 'MOZ_NO_REMOTE': '1', 08:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:58 INFO - 'NO_EM_RESTART': '1', 08:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:58 INFO - 'PWD': '/builds/slave/test', 08:49:58 INFO - 'SHELL': '/bin/bash', 08:49:58 INFO - 'SHLVL': '1', 08:49:58 INFO - 'TERM': 'linux', 08:49:58 INFO - 'TMOUT': '86400', 08:49:58 INFO - 'USER': 'cltbld', 08:49:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:58 INFO - '_': '/tools/buildbot/bin/python'} 08:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 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)) 08:49:59 INFO - Cleaning up... 08:49:59 INFO - Return code: 0 08:49:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:49: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', 'jsonschema'] in /builds/slave/test/build 08:49: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 jsonschema 08:49:59 INFO - Using env: {'DISPLAY': ':0', 08:49:59 INFO - 'HOME': '/home/cltbld', 08:49:59 INFO - 'LANG': 'en_US.UTF-8', 08:49:59 INFO - 'LANGUAGE': 'en_US:en', 08:49:59 INFO - 'LOGNAME': 'cltbld', 08:49:59 INFO - 'MAIL': '/var/mail/cltbld', 08:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:59 INFO - 'MOZ_NO_REMOTE': '1', 08:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:59 INFO - 'NO_EM_RESTART': '1', 08:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:59 INFO - 'PWD': '/builds/slave/test', 08:49:59 INFO - 'SHELL': '/bin/bash', 08:49:59 INFO - 'SHLVL': '1', 08:49:59 INFO - 'TERM': 'linux', 08:49:59 INFO - 'TMOUT': '86400', 08:49:59 INFO - 'USER': 'cltbld', 08:49:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:59 INFO - '_': '/tools/buildbot/bin/python'} 08:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:59 INFO - Downloading/unpacking jsonschema 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:50:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:01 INFO - warning: no files found matching '*.txt' 08:50:01 INFO - no previously-included directories found matching 'build' 08:50:01 INFO - no previously-included directories found matching 'dist' 08:50:01 INFO - no previously-included directories found matching '.git*' 08:50:01 INFO - Installing collected packages: jsonschema, functools32 08:50:01 INFO - Running setup.py install for functools32 08:50:01 INFO - warning: no files found matching '*.txt' 08:50:01 INFO - no previously-included directories found matching 'build' 08:50:01 INFO - no previously-included directories found matching 'dist' 08:50:01 INFO - no previously-included directories found matching '.git*' 08:50:01 INFO - Successfully installed jsonschema functools32 08:50:01 INFO - Cleaning up... 08:50:01 INFO - Return code: 0 08:50:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:01 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 0x7fbc21a03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20da8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, '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': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', '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 08:50:01 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 08:50:01 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 08:50:01 INFO - Using env: {'DISPLAY': ':0', 08:50:01 INFO - 'HOME': '/home/cltbld', 08:50:01 INFO - 'LANG': 'en_US.UTF-8', 08:50:01 INFO - 'LANGUAGE': 'en_US:en', 08:50:01 INFO - 'LOGNAME': 'cltbld', 08:50:01 INFO - 'MAIL': '/var/mail/cltbld', 08:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:01 INFO - 'MOZ_NO_REMOTE': '1', 08:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:01 INFO - 'NO_EM_RESTART': '1', 08:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:01 INFO - 'PWD': '/builds/slave/test', 08:50:01 INFO - 'SHELL': '/bin/bash', 08:50:01 INFO - 'SHLVL': '1', 08:50:01 INFO - 'TERM': 'linux', 08:50:01 INFO - 'TMOUT': '86400', 08:50:01 INFO - 'USER': 'cltbld', 08:50:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:01 INFO - '_': '/tools/buildbot/bin/python'} 08:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:01 INFO - Downloading/unpacking flake8 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:50:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:50:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:04 INFO - no previously-included directories found matching 'docs/_build' 08:50:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:50:04 INFO - Running setup.py install for pep8 08:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:04 INFO - no previously-included directories found matching 'docs/_build' 08:50:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:50:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:50:04 INFO - Cleaning up... 08:50:04 INFO - Return code: 0 08:50:04 INFO - Running post-action listener: _resource_record_post_action 08:50:04 INFO - Running post-action listener: _start_resource_monitoring 08:50:04 INFO - Starting resource monitoring. 08:50:04 INFO - ##### 08:50:04 INFO - ##### Finished create-virtualenv step (success) 08:50:04 INFO - ##### 08:50:04 INFO - ##### 08:50:04 INFO - ##### Running install step. 08:50:04 INFO - ##### 08:50:04 INFO - Running pre-action listener: _resource_record_pre_action 08:50:04 INFO - Running main action method: install 08:50:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:05 INFO - Reading from file tmpfile_stdout 08:50:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:05 INFO - Reading from file tmpfile_stdout 08:50:05 INFO - Output received: 08:50:05 INFO - Usage: mozinstall [options] installer 08:50:05 INFO - Options: 08:50:05 INFO - -h, --help show this help message and exit 08:50:05 INFO - -d DEST, --destination=DEST 08:50:05 INFO - Directory to install application into. [default: 08:50:05 INFO - "/builds/slave/test"] 08:50:05 INFO - --app=APP Application being installed. [default: firefox] 08:50:05 INFO - mkdir: /builds/slave/test/build/application 08:50:05 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'] 08:50:05 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 08:50:21 INFO - Reading from file tmpfile_stdout 08:50:21 INFO - Output received: 08:50:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:21 INFO - Running post-action listener: _resource_record_post_action 08:50:21 INFO - ##### 08:50:21 INFO - ##### Finished install step (success) 08:50:21 INFO - ##### 08:50:21 INFO - ##### 08:50:21 INFO - ##### Running run-tests step. 08:50:21 INFO - ##### 08:50:21 INFO - Running pre-action listener: _resource_record_pre_action 08:50:21 INFO - Running main action method: run_tests 08:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:21 INFO - Python 2.7.3 08:50:21 INFO - Return code: 0 08:50:21 INFO - grabbing minidump binary from tooltool 08:50:21 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')]} 08:50:21 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 0x2169b20>, '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 0x216aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216aeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:21 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 08:50:21 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 08:50:21 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 08:50:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:21 INFO - Return code: 0 08:50:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:50:22 INFO - Return code: 0 08:50:22 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/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:50:22 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/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:50:22 INFO - Using env: {'DISPLAY': ':0', 08:50:22 INFO - 'HOME': '/home/cltbld', 08:50:22 INFO - 'LANG': 'en_US.UTF-8', 08:50:22 INFO - 'LANGUAGE': 'en_US:en', 08:50:22 INFO - 'LOGNAME': 'cltbld', 08:50:22 INFO - 'MAIL': '/var/mail/cltbld', 08:50:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:22 INFO - 'MOZ_NO_REMOTE': '1', 08:50:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:22 INFO - 'NO_EM_RESTART': '1', 08:50:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:22 INFO - 'PWD': '/builds/slave/test', 08:50:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:22 INFO - 'SHELL': '/bin/bash', 08:50:22 INFO - 'SHLVL': '1', 08:50:22 INFO - 'TERM': 'linux', 08:50:22 INFO - 'TMOUT': '86400', 08:50:22 INFO - 'USER': 'cltbld', 08:50:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463500168.992174-80922534', 08:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:22 INFO - '_': '/tools/buildbot/bin/python'} 08:50:22 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/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:50:23 INFO - mozversion application_buildid: 20160517053004 08:50:23 INFO - mozversion application_changeset: 6e2add233b54766d44568f81aa207c624bbe4437 08:50:23 INFO - mozversion application_display_name: Nightly 08:50:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:23 INFO - mozversion application_name: Firefox 08:50:23 INFO - mozversion application_remotingname: firefox 08:50:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:50:23 INFO - mozversion application_vendor: Mozilla 08:50:23 INFO - mozversion application_version: 49.0a1 08:50:23 INFO - mozversion platform_buildid: 20160517053004 08:50:23 INFO - mozversion platform_changeset: 6e2add233b54766d44568f81aa207c624bbe4437 08:50:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:50:23 INFO - mozversion platform_version: 49.0a1 08:50:23 INFO - using testdate: 1463500223 08:50:23 INFO - actual date: 1463500223 08:50:23 INFO - starting webserver on 'localhost:53224' 08:50:23 INFO - SUITE-START | Running 2 tests 08:50:23 INFO - TEST-START | dromaeo_css 08:50:23 INFO - operating with platform_type : linux_ 08:50:23 INFO - Initialising browser for dromaeo_css test... 08:50:23 INFO - TEST-INFO | started process 20454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_PbO7/profile http://localhost:53224/getInfo.html) 08:50:26 INFO - PROCESS | 20454 | __metrics Screen width/height:1600/1200 08:50:26 INFO - PROCESS | 20454 | colorDepth:24 08:50:26 INFO - PROCESS | 20454 | Browser inner width/height: 1024/697 08:50:26 INFO - PROCESS | 20454 | __metrics 08:50:27 ERROR - PROCESS | 20454 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:50:28 INFO - TEST-INFO | 20454: exit 0 08:50:28 INFO - Browser initialized. 08:50:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:28 INFO - TEST-INFO | started process 20535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_PbO7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:40 INFO - PROCESS | 20535 | RSS: Main: 152174592 08:50:40 INFO - PROCESS | 20535 | 08:51:31 INFO - PROCESS | 20535 | 1463500291618 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] 08:53:39 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53224/tests/dromaeo/cssquery-ext.html) 08:53:40 INFO - PROCESS | 20535 | RSS: Main: 260161536 08:53:40 INFO - PROCESS | 20535 | 08:56:42 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-ext.html (next: http://localhost:53224/tests/dromaeo/cssquery-jquery.html) 08:56:43 INFO - PROCESS | 20535 | RSS: Main: 234004480 08:56:43 INFO - PROCESS | 20535 | 08:59:45 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53224/tests/dromaeo/cssquery-mootools.html) 08:59:46 INFO - PROCESS | 20535 | RSS: Main: 244793344 08:59:46 INFO - PROCESS | 20535 | 09:02:47 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53224/tests/dromaeo/cssquery-prototype.html) 09:02:48 INFO - PROCESS | 20535 | RSS: Main: 233955328 09:02:48 INFO - PROCESS | 20535 | 09:05:51 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53224/tests/dromaeo/cssquery-yui.html) 09:05:51 INFO - PROCESS | 20535 | RSS: Main: 214102016 09:05:51 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | Cycle 1(1): loaded http://localhost:53224/tests/dromaeo/cssquery-yui.html (next: http://localhost:53224/tests/dromaeo/cssquery-dojo.html) 09:08:54 INFO - PROCESS | 20535 | RSS: Main: 269660160 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | __start_tp_report 09:08:54 INFO - PROCESS | 20535 | _x_x_mozilla_page_load 09:08:54 INFO - PROCESS | 20535 | _x_x_mozilla_page_load_details 09:08:54 INFO - PROCESS | 20535 | |i|pagename|runs| 09:08:54 INFO - PROCESS | 20535 | |0;dojo.html;3162.924605634084;3165.145410739102;3193.1538142392264;3204.759643026771;3228.015455286138;5303.867403314919;5326.973365133169;5356.839294821152;5385.380681221661;5393.81121660742;5357.223202635615;5375.462453754622;5375.973120134404;5399.271098401715;5421.810236641718;4885.267209918523;4950.084234416627;4965.528274813905;4975.925361119586;5166.819161329354;5063.518965698253;5071.442141364447;5099.388073431175;5130.4356520782685;5139.203423469349;4852;4891.559759621651;4892.0705066037335;4933.235348520985;4979.302897594322;4844.176489996709;4871.342368780205;4947.455779864212;4962.255661650745;4994.800207991676;4830.806767729287;4924.630652701026;4940.851774446773;4953.554180123806;4970.552650261494;5333.573314134898;5374.193870919355;5394.973025134849;5434.809781657623;5448.073827449343;5858.794942177046;5866.76532938682;5885.911711324334;5889.882202355929;5918.201042859245;5694.032014557535;5734.311882574076;5734.684592347419;5849.6197747146725;5879.559033072494;5437.864053398657;5466.316710411199;5477.04151773442;5478.534324582375;5484.91772623411;5941.22764040672;5949.315828679671;5950.851228719317;5952;5954.434328738849;5487.807926722546;5670.914936275959;5710.885782284331;5722.456366645245;5736.77052917887;5815.447532484407;5829.621074630136;5838.211841401441;5887.646741195542;5891.3224979127945;5811.244538210006;5812.9709351452975;5814.622049566765;5818.185454036438;5822.359540450547;5625;5755.539556835443;5821.854453638693;5844.503217226498;5886.23478947734;4433.778311084498;4443.244648409778;4447.755373454491;4450.554944505524;4491.416115904912;3847.076701591598;3964.7224694271126;3995.081131339808;4019.0957034666967;4062.8171732272117;5474.206240095164;5517.337919449692;5537.612367134342;5565.053940830068;5585.804496842591;5927.2590926134235;5928.970355148283;5929.851753706192;5936.28764548257;5939.406059394112;5290.206469029677;5439.619226654097;5554;5567.331920169525;5569.470900264469;4991.850244492598;5004.524570165829;5028.044671512401;5045.268436076748;5066.265391518209;6089.695515224221;6097.878042439215;6104.542159338067;6105.175801266861;6117.663528505975;5634.23937768396;5785.30576330843;5807.535397168132;5859.794907178229;5874.353821079763;5986.431289027535;6064.4541991221;6065.332813390612;6069.817905462844;6099.298580663103;5703.45817147387;5726.9713651431475;5748.051571490657;5755.1367294906095;5755.482006619424;5601.047821870373;5778.133280008033;5804.245448091721;5811.302643682785;5832.212651292191;5720.313562372542;5720.742566584597;5725.7137143141845;5727.799527016535;5730.742116604846;5635.746391412478;5669.234653321749;5681.176229446624;5705;5718.285214348207;5413.052715774802;5472.370677372153;5494.670319780826;5548.805791797267;5585.553155747449;5667.40492248308;5669.461401166883;5722.399148089391;5731.398203188605;5756.65460072397;5506.476884695948;5515.448455154613;5554.444555544414;5558.555315574825;5604.019296623156 09:08:54 INFO - PROCESS | 20535 | |1;ext.html;593.2584269662922;628.6605233174087;633.547013885072;648.6043513456791;657.4608820766973;42951;44120.779396102975;44194;44202;47476.0504789904;45803;46223.30665040027;46353.7682311588;46358.76820615892;46381.53618463814;8935.91064089359;9069.909300907006;9074.36479446439;9079.500627465486;9081.273498120168;8978.057303983085;9055.275577953747;9074.455532668027;9080.727578172666;9086.772830679252;9159.725208243763;9208.309376796733;9208.861867071999;9212.953935230315;9216.078392160764;9101.544922753836;9103.271738260923;9121.315901307395;9137.451752894847;9155.587998540082;8845.469271843709;8912;8918.687845925426;8924.553772311423;8931.73204803857;42079.36880946788;42366.78816605928;42445.36331955023;42467.36298955518;42537.36193957093;3416.180116771982;3468.3410152071024;3516.0682419158943;3550.4851796489625;4065.8780236592947;31848.6815131848;32340;32530.349393012242;32545.837270813732;33661.15847103842;4209.515905670826;4223.514295855985;4251.80866860992;4268.637165840907;4325.956740432587;325146;325857;326187.36906315555;326409;326985;54350;60490.39509604847;61385.69307153525;61525.69237153786;61531;62519.374806252265;63045.369546304864;63464;69653.65173174204;69968.30031699719;15585.844141558438;15690;15709.528714138594;15722.449714259947;15728.68542629141;11968.222065565711;12176.878231217574;12996.545120920722;13099.345032748515;13119.147255428366;18169.36407225741;18497.167627456798;18559;19178.424647260603;19439.90280048619;6542.345765423514;6812.080369150101;6839.110915580943;6864.107666003488;6872.450203983669;943.8065196634674;1072.383379556758;1109.839073334362;1120.3389999899935;1180.0087926142082;33885;33934.32131357359;34297;34595.859048377264;34790.82604586961;1118.7147277444362;1161.6689243565543;1171.666075168573;1174.8237764335418;1176.4941075337515;17151.571210719583;18044.548886277684;18073.45779626613;18106.909465452587;18175.272989080553;511907;512432;512490;516231;520440;56074;57430.69269804782;57500;57542.42457575371;57608.71195644079;1266.6769973656658;1287.575100216926;1369.0895554456174;1402.4320150338924;1405.1990365491572;32700.83649581737;35259;35303.47044794279;35335.46996794999;35524.111897202776;51250.23124653208;51415.74292128516;51918;51962.220566690776;51995.2200716982;384355;385369;385385;387862;388834;34737.82631086929;42318.999451891716;43251;46437.76781116073;46624.76687616676;49229.261561075895;49266.75366623144;49698.254526182856;49724.751376242886;49848.25227621661;40419.595804041586;41462.79268603637;41587.37618935779;41746;42635.57364426316;41001.79499102486;41453.58546414497;41980.58019419889;42712.14575708531;42768.14463710646;42094.36858447187;42209.36685949775;42402.15195696007;43217.135657286046;43581;36544;37124.25751485009;37380.81309593435;37575;37935.24129517449;28960.855195723885;28971.5654265182;29333.70666293395;29353.412931741674;29451.263718406353 09:08:54 INFO - PROCESS | 20535 | |2;jquery.html;389.2934324201572;399.6123759952845;400.6614410822855;400.8977710683776;412.65337116821865;12929.167037597563;19261.807381926177;19396.70904936427;20085.799142008593;20098.49753756157;14678.779818302733;16584.751228731548;18212.63574728508;18347.35784247548;18633;5574.637648552841;5690.772369105231;5707.743151558169;5717.514011309044;5739.139129130622;5608.495235428811;5724.570657200706;5764.567657425689;5764.7982320618785;5769.971150144243;4031.475908131939;5608.971955140239;5910;6215.720292586844;6219.067139929024;6197.504199664061;6273.404026617464;6274.466670333004;6301.495880329586;6317.905231421532;5496.258005169291;5609.859753506195;5633.887322253573;5636.126400407943;5637.71811409432;21981.67027494589;21983.120675172973;22602.660960085614;22613;22969.42576435586;2428.417179876817;2757.7793776497833;3166.4617015107488;3182.474891642876;3201.695838895301;13878.167309961435;14007.719845603031;14070.85929140716;14345.71308573833;14672.193029383487;1969.4682435742413;1973.822355987968;1984.1765667248076;1989.433011591704;2027.7566691996908;79116.20883791204;79409.60295198545;81018.59490702568;81651;82768.58615706943;10646.787064258671;10790.67627971162;10818;10917.672469825919;11031.613893513688;15188.696226075417;15222.46721364747;15225.238738063052;15249;15302.387904483918;7819.609019549113;7883.645235964395;8000.199980001953;8094.231048050426;8124.22819832115;7459.925400745923;7609.440064786705;7637.15991240963;7676.654550545239;7719.343855772322;5847.298324201123;6154.692265386713;6703.798886033329;6721.66391680414;6825.146856642919;1830.8908217165035;1962.4603234110734;1988.4829944214318;1991.392625249313;2018.64673682108;959.7984423271051;1041.6926010944646;1080.0865262686727;1080.8108580998294;1114.5876025870318;19084.14121364542;19427.4171774847;19464.513387165433;19497.610047798964;19820.60358792816;1041.1514615588271;1046.3669479964665;1070.82866741321;1092.1617235646163;1136.9147313951487;10361.844572331422;11337.829932551018;11397.487113079931;11419.714507137389;11423.086153107732;355304;363678;365418;460934;481055;91844;96730.51634741781;97197.5140124309;97412.51293743486;97735.51132244294;1033.1424917318607;1065.5471424644495;1066.3282132256784;1069.3744159666526;1076.1552181537456;16343.754843677116;17390.391336303168;17462.563435914202;17647.117644117487;17757;37400;38774;39385.80307098446;39438.80280598579;40542;54354.72822635862;56980.14529782139;57286.42713572811;57616.135757962824;57806.71096644658;7602.391808655184;7997.680092796456;8487.27858132041;8567.186117318844;8608.741737747878;13126.343682816012;13269.668258293234;13326.733465330833;13450.86549134496;13660.316984150952;11872.347020913587;12057.276563406223;12249.142560020713;12277.447514862031;12288.692782680504;11719.941400292944;12068.879311206776;12123;12147;12311.876881231432;12258.509659613872;12399.75200496003;12405.75188496243;12522.123451358317;12532.185407948455;7645.770626881203;8013.759587212393;8097.757067287991;8195.67217311301;8227.218414250636;9300.813983720152;11505.539778408769;12235.510579577074;12298.385080746106;12342.938285308515 09:08:54 INFO - PROCESS | 20535 | |3;mootools.html;1376.483818568037;1549.2563569486642;1557.5794535475418;1760.2518929454986;1889.272630037436;8623.956880215597;9006.639734410632;9015;9276.721698349043;9305.906940930605;9030.187283144516;9249.491277979709;9250.67622633208;9264;9265.861012084808;2096.5806838632257;2163.610550100981;2167.6531754919215;2374.287713685896;2401.86789726565;2375.501144759594;2456.435019945414;2457.9016839326405;2465.3713303107684;2470.147799009339;2395.197608801054;2400.1839374612628;2403.51929614077;2404.8076153907646;2440.048381131351;2021.3733742539712;2317.2121478697154;2391.390195500154;2423.9515209695796;2424.612062070078;2386.2602593195993;2420.4190994161277;2422.987885060581;2426.5146970605774;2427.5751743444825;8848.911510884938;8864.8670269946;8919.821603567958;8920.598573064228;8925.33060020501;5205.453427390145;5358.973205133989;5374.543163831079;5384.515393614554;5393.973030134864;3372.8988130355883;3380.6281309055985;3544.85820567177;3556.022093924166;3567.4470457079196;1126.4761885723096;1157.2940506291156;1180.9763804723943;1196.114874992508;1196.5871774237874;12998.480060797652;13010.154339967967;13017.21896686202;13025.088243822936;13034.739305213843;4844.8304309349005;4857;4921.089598424303;4922.704637721748;4927.852164435073;10993.725156871142;11031.779364412667;11062.170337224741;11064.889351106547;11067.778644427228;5385.192221166856;5438.564914806806;5449.155380915964;5452.700101494376;5458.235846981426;4892.046051020017;4962.03240368132;4994.675346102492;5012.7994880205115;5028.547430731252;3792.355299599075;3857.8071096445065;3895.7662540247675;3914.784686842194;3951.4270430787374;1163.7323415614455;1180.2151569206553;1185.2947496239724;1186.9703257418635;1196.0969468051564;1014.2342531388754;1022.1822541966397;1036.2021243642353;1045.6706137566794;1053.7365658585354;6291.591046581958;6326.68366581669;6355.3644635537;6366.140571022853;6503.349665033459;459.69889722231994;459.87353477793874;465.25326850405287;1049.2497864027257;1137.3176094343328;4059.918801623951;4156.688248381383;4274.615284624399;4314.654827613784;4337.848175313912;11274.098072154207;11489.827652585218;11650.475728592233;11663.533458661559;11678.708032299091;11498.540058397737;11543.538258469735;11552.826707599394;11581.652550423501;11594.942025289989;7938.761837144895;8298.170182981774;8359.289460395934;8370;8501.744947651581;6386.201724784402;6515.250746164252;6593.307702691149;6613.2394774601535;6628.436582890508;10555.261131720707;10657.946710266398;10698.197635177237;10797.082248009006;10804.189685773441;9796.608135674493;9994.20046396272;10601;10911.83632245501;10956.671299860698;8222.876656850272;8269.751907442786;8440.240378365976;8464.153584641734;8498.660053598034;8854.690085846965;8994.235489983424;8994.865077023718;9001.279897608307;9005.729828105168;7848.686052557834;8242.917570824215;8253.83492330162;8359.289460395692;8381.16188381157;7744.186860379805;7799.805004874924;7901.328387087162;8081.83836323282;8104.959475202586;7143.9285607143265;7154.534955227893;7396.815079623052;7398.704051837866;7399.963000184965;5419.566434685295;5495.780168793203;5501.367342755634;5514.558835293086;5613.522850557748;5409.78360865561;5458.672479651074;5492.093804522209;5562.276904002454;5666.490015898589 09:08:54 INFO - PROCESS | 20535 | |4;prototype.html;320.9486482162853;325.3639135490117;332.5593588495243;332.9246533696161;336.0339025302256;5290.8412747617585;5345.492178243061;5354.437784032674;5403.78384864605;5422.539084177844;5208.374995000605;5253.343332083489;5290.444503327153;5291.6031297652635;5323.973380133104;4177.7493350399;4190.601892820177;4190.889414305211;4216.47294088239;4221.641160501345;4009.3184158693093;4088.5281298732434;4194.517630472489;4216.5572614875455;4216.891554222889;4152.875413737577;4157.771322577257;4164.625183733463;4183.477065366829;4192.685548583853;4030.496187976503;4128.298189307825;4171;4181.853635122771;4205.432266643995;3644.416893297086;3733.663970242691;3749.531308586427;3756.211195648917;3761.1913438610554;5121.975604879002;5140.049090918154;5161.896762064775;5181.222816577506;5181.430042695338;4606.884827879297;4738.644601654855;4764.523547645243;4805.279208118775;4829.830955916561;5540.168974653794;5544.61187716856;5560.888782224333;5562.969516126625;5567.248421463091;4083.734557253799;4090.8363665453644;4103.9179216415805;4110.321796903508;4170.061736109351;5619.381867994517;5695.686737229492;5761.48146666802;5773.797917072882;5789.710514474259;4194.741577526791;4195.790210489463;4197.937030944478;4199.874003779892;4209.389638502461;4265.658747300208;4271.060366719316;4283.828646854154;4294.806733696991;4297.72064815786;4807.903841923142;4822.68652537584;4856.587190088811;4861;4865.732384718804;5375.19372094189;5603.534444844256;5612.550995920316;5615.213870058195;5636.887262254814;1423.8789702875372;1444.8699617034517;1445.6096853849401;1456.6649670575828;1460.889723809891;864.9048604653483;906.7506435730095;915.2815040193416;918.8376703470116;924.2900633827365;4827.348307978448;5174.508421699932;5298.92051619226;5383.757730902119;5413.675179489243;5682.346530149003;5691.743871525791;5722.713864306768;5745.511631511368;5771.105478650816;5212;5378.1663842104535;5390.838274851761;5414.972925135428;5426.321709786277;2989.536621823577;2989.7309242168308;3003.294225856922;3019.818810871355;3053.206166396753;5811.198528456108;5874.9118763218585;5875.794347197828;5900.911486327708;5904.881902362014;5706.514946229617;5716.685582292931;5855.531557475391;5870.73581688825;5886.02755608415;5853.4731874132385;5853.531717462678;5897.174395584621;5904.734286957183;5955.940440595626;5483.643563168382;5723.6851973141875;5726.828195154152;5735.8852822944145;5750.7987220447085;5606.383297837317;5633.6619802811965;5641.37944826077;5642.60501764889;5661.207430959586;5899.351071382059;5913.013927966522;5914.349421563538;5918.970405147947;5926.377730338252;3890.4942357493346;4111.876643700693;4131.586841315844;4131.731437456556;4131.938020929749;5645.125005624135;5671.234383358194;5732.942670573241;5748.712564371848;5763.366029736641;5519.917201242065;5525.834224973097;5576.302962129734;5600.635958662674;5625.606207565431;5337.546308563816;5533.3083364579425;5534.1975413564005;5545.694986775605;5546.639468434539;5435.456454354533;5459.727013649381;5466.699331536644;5469.507744303032;5506.311711036121;5394.676319420691;5443.802363480028;5623.156526521055;5623.629433890706;5652.180433836988;5479;5490.5882058844945;5496.642718223303;5499.9100341871435;5500.724963751876 09:08:54 INFO - PROCESS | 20535 | |5;yui.html;811.9431639785215;819.3527113580271;855.1106848877164;858.729500207435;863.7106569299284;14370.49703260386;15210;15380.615484612876;15411.306491207895;15432.69134617307;14037.36831842567;14097.365618547165;14100;14102.788458173136;14110.929445352758;706.4701473894579;812.553095797312;829.8049958259804;832.4006715165086;835.9665613375457;836.5440834745048;838.0655569040506;841.4866931172011;844.7888027993001;844.923956843884;901.301491344207;901.945883247004;902.8104098139365;902.8149229407956;903.3766700976305;747.7495039161887;872.1714371347214;896.601012549419;897.582624079806;900.3652425040331;651.2152855808787;651.820749293948;652.1749986267375;652.2433976587183;652.3052948609762;14255.714885702331;14328.85671143296;14347.354369053417;14379.640508987255;14381.856181438156;13500.729985400238;13615.863841361657;13734.903831817464;13736.65658358539;13843.169409835442;11827.645170644895;11829.881701182963;11920.225185362924;11946.28322300656;12007.699807504794;4360.869173924787;4415.4259946206785;4434.401355816955;4538.410006699108;4550.817967281305;53181.46818531804;53302.200466993025;53340.73329633327;53667;53868.730656346466;11045.226834121695;11125.109991200685;11131.053860421955;11230.7192320191;11730;19182.328618498286;19223.423297301102;19226.654134210752;19230.423087307405;19241.615167696567;7910;8169.795755106051;8357.707480238285;8601.483910965362;8713.433626814236;4576.839810606612;4610.492845786961;4611.377464042312;4612.7001744886475;4781.187198176319;3430.485427185942;3516.6483351665142;3517.8065206413894;3521.5774107107313;3522.5772907251294;539.9541039011649;654.2933631677777;655.0926966151914;660.1517050589969;694.0179645801135;753.4800987318732;770.0123520739495;784.0395515493475;804.5977011494252;812.4069429316633;9861.767279090114;10598.523066462029;10607.787844243072;10642.361458312525;10683.626073087406;691.9411849992807;709.2340272505785;730.3499885102264;740.9962950185214;764.289211033744;4815.181419158752;4906.705597664151;4915.85033878431;5012.1980483122525;5017.523335283142;72326.27673723195;74244.62877685577;75537;75986.62006689931;76360.23639763643;66829.33170668328;66861;67135;68621.31378686249;69063;55269.44730552723;56118.15822762662;56151.71924140353;60615.69692151511;61612;9758.951205243928;9832.852507212541;10210.744731381776;10281;10290.948545257525;36589.81705091458;36671.449928250564;37437.2512549742;37837.918914459966;38649.22701545897;46725.76637116793;49463.50536494589;49893.75053124711;50690.23964640607;51830.74084629553;12394.194377365802;12564.120511564102;12584.937075314565;13106.60680179596;13207.60377188686;13951.581452556033;14861.554153375417;14869.323521766186;15194.696106078038;15390;13819.723605527632;14171.929140354645;14627.268636567916;14650.340734666752;14742.2628868554;13325.800112998506;13841.307934603028;14099;14208.857911420753;14313.785293220402;13461.528846490326;13697.109687870257;14295.356708947915;14313.141211527342;14399.136051836924;11420.428978551205;11474.598389056342;11659.417029148339;11680.824787628362;11902.821457678316;10834.241603087708;11065.391403472886;11077.667669969915;11143.498542565441;11214.551417943518 09:08:54 INFO - PROCESS | 20535 | __end_tp_report 09:08:54 INFO - PROCESS | 20535 | __start_cc_report 09:08:54 INFO - PROCESS | 20535 | _x_x_mozilla_cycle_collect,891 09:08:54 INFO - PROCESS | 20535 | __end_cc_report 09:08:54 INFO - PROCESS | 20535 | __startTimestamp1463501334802__endTimestamp 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | ------- Summary: start ------- 09:08:54 INFO - PROCESS | 20535 | Number of tests: 6 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#0] dojo.html Cycles:165 Average:5406.35 Median:5569.47 stddev:610.16 (11.0%) stddev-sans-first:586.10 09:08:54 INFO - PROCESS | 20535 | Values: 3162.9 3165.1 3193.2 3204.8 3228.0 5303.9 5327.0 5356.8 5385.4 5393.8 5357.2 5375.5 5376.0 5399.3 5421.8 4885.3 4950.1 4965.5 4975.9 5166.8 5063.5 5071.4 5099.4 5130.4 5139.2 4852.0 4891.6 4892.1 4933.2 4979.3 4844.2 4871.3 4947.5 4962.3 4994.8 4830.8 4924.6 4940.9 4953.6 4970.6 5333.6 5374.2 5395.0 5434.8 5448.1 5858.8 5866.8 5885.9 5889.9 5918.2 5694.0 5734.3 5734.7 5849.6 5879.6 5437.9 5466.3 5477.0 5478.5 5484.9 5941.2 5949.3 5950.9 5952.0 5954.4 5487.8 5670.9 5710.9 5722.5 5736.8 5815.4 5829.6 5838.2 5887.6 5891.3 5811.2 5813.0 5814.6 5818.2 5822.4 5625.0 5755.5 5821.9 5844.5 5886.2 4433.8 4443.2 4447.8 4450.6 4491.4 3847.1 3964.7 3995.1 4019.1 4062.8 5474.2 5517.3 5537.6 5565.1 5585.8 5927.3 5929.0 5929.9 5936.3 5939.4 5290.2 5439.6 5554.0 5567.3 5569.5 4991.9 5004.5 5028.0 5045.3 5066.3 6089.7 6097.9 6104.5 6105.2 6117.7 5634.2 5785.3 5807.5 5859.8 5874.4 5986.4 6064.5 6065.3 6069.8 6099.3 5703.5 5727.0 5748.1 5755.1 5755.5 5601.0 5778.1 5804.2 5811.3 5832.2 5720.3 5720.7 5725.7 5727.8 5730.7 5635.7 5669.2 5681.2 5705.0 5718.3 5413.1 5472.4 5494.7 5548.8 5585.6 5667.4 5669.5 5722.4 5731.4 5756.7 5506.5 5515.4 5554.4 5558.6 5604.0 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#1] ext.html Cycles:180 Average:58634.93 Median:42456.36 stddev:110036.14 (259.2%) stddev-sans-first:110258.53 09:08:54 INFO - PROCESS | 20535 | Values: 593.3 628.7 633.5 648.6 657.5 42951.0 44120.8 44194.0 44202.0 47476.1 45803.0 46223.3 46353.8 46358.8 46381.5 8935.9 9069.9 9074.4 9079.5 9081.3 8978.1 9055.3 9074.5 9080.7 9086.8 9159.7 9208.3 9208.9 9213.0 9216.1 9101.5 9103.3 9121.3 9137.5 9155.6 8845.5 8912.0 8918.7 8924.6 8931.7 42079.4 42366.8 42445.4 42467.4 42537.4 3416.2 3468.3 3516.1 3550.5 4065.9 31848.7 32340.0 32530.3 32545.8 33661.2 4209.5 4223.5 4251.8 4268.6 4326.0 325146.0 325857.0 326187.4 326409.0 326985.0 54350.0 60490.4 61385.7 61525.7 61531.0 62519.4 63045.4 63464.0 69653.7 69968.3 15585.8 15690.0 15709.5 15722.4 15728.7 11968.2 12176.9 12996.5 13099.3 13119.1 18169.4 18497.2 18559.0 19178.4 19439.9 6542.3 6812.1 6839.1 6864.1 6872.5 943.8 1072.4 1109.8 1120.3 1180.0 33885.0 33934.3 34297.0 34595.9 34790.8 1118.7 1161.7 1171.7 1174.8 1176.5 17151.6 18044.5 18073.5 18106.9 18175.3 511907.0 512432.0 512490.0 516231.0 520440.0 56074.0 57430.7 57500.0 57542.4 57608.7 1266.7 1287.6 1369.1 1402.4 1405.2 32700.8 35259.0 35303.5 35335.5 35524.1 51250.2 51415.7 51918.0 51962.2 51995.2 384355.0 385369.0 385385.0 387862.0 388834.0 34737.8 42319.0 43251.0 46437.8 46624.8 49229.3 49266.8 49698.3 49724.8 49848.3 40419.6 41462.8 41587.4 41746.0 42635.6 41001.8 41453.6 41980.6 42712.1 42768.1 42094.4 42209.4 42402.2 43217.1 43581.0 36544.0 37124.3 37380.8 37575.0 37935.2 28960.9 28971.6 29333.7 29353.4 29451.3 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#2] jquery.html Cycles:180 Average:26771.04 Median:22607.83 stddev:68027.95 (300.9%) stddev-sans-first:68189.95 09:08:54 INFO - PROCESS | 20535 | Values: 389.3 399.6 400.7 400.9 412.7 12929.2 19261.8 19396.7 20085.8 20098.5 14678.8 16584.8 18212.6 18347.4 18633.0 5574.6 5690.8 5707.7 5717.5 5739.1 5608.5 5724.6 5764.6 5764.8 5770.0 4031.5 5609.0 5910.0 6215.7 6219.1 6197.5 6273.4 6274.5 6301.5 6317.9 5496.3 5609.9 5633.9 5636.1 5637.7 21981.7 21983.1 22602.7 22613.0 22969.4 2428.4 2757.8 3166.5 3182.5 3201.7 13878.2 14007.7 14070.9 14345.7 14672.2 1969.5 1973.8 1984.2 1989.4 2027.8 79116.2 79409.6 81018.6 81651.0 82768.6 10646.8 10790.7 10818.0 10917.7 11031.6 15188.7 15222.5 15225.2 15249.0 15302.4 7819.6 7883.6 8000.2 8094.2 8124.2 7459.9 7609.4 7637.2 7676.7 7719.3 5847.3 6154.7 6703.8 6721.7 6825.1 1830.9 1962.5 1988.5 1991.4 2018.6 959.8 1041.7 1080.1 1080.8 1114.6 19084.1 19427.4 19464.5 19497.6 19820.6 1041.2 1046.4 1070.8 1092.2 1136.9 10361.8 11337.8 11397.5 11419.7 11423.1 355304.0 363678.0 365418.0 460934.0 481055.0 91844.0 96730.5 97197.5 97412.5 97735.5 1033.1 1065.5 1066.3 1069.4 1076.2 16343.8 17390.4 17462.6 17647.1 17757.0 37400.0 38774.0 39385.8 39438.8 40542.0 54354.7 56980.1 57286.4 57616.1 57806.7 7602.4 7997.7 8487.3 8567.2 8608.7 13126.3 13269.7 13326.7 13450.9 13660.3 11872.3 12057.3 12249.1 12277.4 12288.7 11719.9 12068.9 12123.0 12147.0 12311.9 12258.5 12399.8 12405.8 12522.1 12532.2 7645.8 8013.8 8097.8 8195.7 8227.2 9300.8 11505.5 12235.5 12298.4 12342.9 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#3] mootools.html Cycles:180 Average:6064.11 Median:459.79 stddev:3502.00 (761.7%) stddev-sans-first:3494.11 09:08:54 INFO - PROCESS | 20535 | Values: 1376.5 1549.3 1557.6 1760.3 1889.3 8624.0 9006.6 9015.0 9276.7 9305.9 9030.2 9249.5 9250.7 9264.0 9265.9 2096.6 2163.6 2167.7 2374.3 2401.9 2375.5 2456.4 2457.9 2465.4 2470.1 2395.2 2400.2 2403.5 2404.8 2440.0 2021.4 2317.2 2391.4 2424.0 2424.6 2386.3 2420.4 2423.0 2426.5 2427.6 8848.9 8864.9 8919.8 8920.6 8925.3 5205.5 5359.0 5374.5 5384.5 5394.0 3372.9 3380.6 3544.9 3556.0 3567.4 1126.5 1157.3 1181.0 1196.1 1196.6 12998.5 13010.2 13017.2 13025.1 13034.7 4844.8 4857.0 4921.1 4922.7 4927.9 10993.7 11031.8 11062.2 11064.9 11067.8 5385.2 5438.6 5449.2 5452.7 5458.2 4892.0 4962.0 4994.7 5012.8 5028.5 3792.4 3857.8 3895.8 3914.8 3951.4 1163.7 1180.2 1185.3 1187.0 1196.1 1014.2 1022.2 1036.2 1045.7 1053.7 6291.6 6326.7 6355.4 6366.1 6503.3 459.7 459.9 465.3 1049.2 1137.3 4059.9 4156.7 4274.6 4314.7 4337.8 11274.1 11489.8 11650.5 11663.5 11678.7 11498.5 11543.5 11552.8 11581.7 11594.9 7938.8 8298.2 8359.3 8370.0 8501.7 6386.2 6515.3 6593.3 6613.2 6628.4 10555.3 10657.9 10698.2 10797.1 10804.2 9796.6 9994.2 10601.0 10911.8 10956.7 8222.9 8269.8 8440.2 8464.2 8498.7 8854.7 8994.2 8994.9 9001.3 9005.7 7848.7 8242.9 8253.8 8359.3 8381.2 7744.2 7799.8 7901.3 8081.8 8105.0 7143.9 7154.5 7396.8 7398.7 7400.0 5419.6 5495.8 5501.4 5514.6 5613.5 5409.8 5458.7 5492.1 5562.3 5666.5 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#4] prototype.html Cycles:180 Average:4705.49 Median:5387.30 stddev:1371.38 (25.5%) stddev-sans-first:1335.15 09:08:54 INFO - PROCESS | 20535 | Values: 320.9 325.4 332.6 332.9 336.0 5290.8 5345.5 5354.4 5403.8 5422.5 5208.4 5253.3 5290.4 5291.6 5324.0 4177.7 4190.6 4190.9 4216.5 4221.6 4009.3 4088.5 4194.5 4216.6 4216.9 4152.9 4157.8 4164.6 4183.5 4192.7 4030.5 4128.3 4171.0 4181.9 4205.4 3644.4 3733.7 3749.5 3756.2 3761.2 5122.0 5140.0 5161.9 5181.2 5181.4 4606.9 4738.6 4764.5 4805.3 4829.8 5540.2 5544.6 5560.9 5563.0 5567.2 4083.7 4090.8 4103.9 4110.3 4170.1 5619.4 5695.7 5761.5 5773.8 5789.7 4194.7 4195.8 4197.9 4199.9 4209.4 4265.7 4271.1 4283.8 4294.8 4297.7 4807.9 4822.7 4856.6 4861.0 4865.7 5375.2 5603.5 5612.6 5615.2 5636.9 1423.9 1444.9 1445.6 1456.7 1460.9 864.9 906.8 915.3 918.8 924.3 4827.3 5174.5 5298.9 5383.8 5413.7 5682.3 5691.7 5722.7 5745.5 5771.1 5212.0 5378.2 5390.8 5415.0 5426.3 2989.5 2989.7 3003.3 3019.8 3053.2 5811.2 5874.9 5875.8 5900.9 5904.9 5706.5 5716.7 5855.5 5870.7 5886.0 5853.5 5853.5 5897.2 5904.7 5955.9 5483.6 5723.7 5726.8 5735.9 5750.8 5606.4 5633.7 5641.4 5642.6 5661.2 5899.4 5913.0 5914.3 5919.0 5926.4 3890.5 4111.9 4131.6 4131.7 4131.9 5645.1 5671.2 5732.9 5748.7 5763.4 5519.9 5525.8 5576.3 5600.6 5625.6 5337.5 5533.3 5534.2 5545.7 5546.6 5435.5 5459.7 5466.7 5469.5 5506.3 5394.7 5443.8 5623.2 5623.6 5652.2 5479.0 5490.6 5496.6 5499.9 5500.7 09:08:54 INFO - PROCESS | 20535 | 09:08:54 INFO - PROCESS | 20535 | [#5] yui.html Cycles:180 Average:16306.64 Median:4544.61 stddev:19626.56 (431.9%) stddev-sans-first:19647.12 09:08:54 INFO - PROCESS | 20535 | Values: 811.9 819.4 855.1 858.7 863.7 14370.5 15210.0 15380.6 15411.3 15432.7 14037.4 14097.4 14100.0 14102.8 14110.9 706.5 812.6 829.8 832.4 836.0 836.5 838.1 841.5 844.8 844.9 901.3 901.9 902.8 902.8 903.4 747.7 872.2 896.6 897.6 900.4 651.2 651.8 652.2 652.2 652.3 14255.7 14328.9 14347.4 14379.6 14381.9 13500.7 13615.9 13734.9 13736.7 13843.2 11827.6 11829.9 11920.2 11946.3 12007.7 4360.9 4415.4 4434.4 4538.4 4550.8 53181.5 53302.2 53340.7 53667.0 53868.7 11045.2 11125.1 11131.1 11230.7 11730.0 19182.3 19223.4 19226.7 19230.4 19241.6 7910.0 8169.8 8357.7 8601.5 8713.4 4576.8 4610.5 4611.4 4612.7 4781.2 3430.5 3516.6 3517.8 3521.6 3522.6 540.0 654.3 655.1 660.2 694.0 753.5 770.0 784.0 804.6 812.4 9861.8 10598.5 10607.8 10642.4 10683.6 691.9 709.2 730.3 741.0 764.3 4815.2 4906.7 4915.9 5012.2 5017.5 72326.3 74244.6 75537.0 75986.6 76360.2 66829.3 66861.0 67135.0 68621.3 69063.0 55269.4 56118.2 56151.7 60615.7 61612.0 9759.0 9832.9 10210.7 10281.0 10290.9 36589.8 36671.4 37437.3 37837.9 38649.2 46725.8 49463.5 49893.8 50690.2 51830.7 12394.2 12564.1 12584.9 13106.6 13207.6 13951.6 14861.6 14869.3 15194.7 15390.0 13819.7 14171.9 14627.3 14650.3 14742.3 13325.8 13841.3 14099.0 14208.9 14313.8 13461.5 13697.1 14295.4 14313.1 14399.1 11420.4 11474.6 11659.4 11680.8 11902.8 10834.2 11065.4 11077.7 11143.5 11214.6 09:08:54 INFO - PROCESS | 20535 | -------- Summary: end -------- 09:08:54 INFO - PROCESS | 20535 | 09:08:55 INFO - TEST-INFO | 20535: exit 0 09:08:55 INFO - TEST-OK | dromaeo_css | took 1112447ms 09:08:55 INFO - TEST-START | kraken 09:08:55 INFO - operating with platform_type : linux_ 09:08:55 INFO - Initialising browser for kraken test... 09:08:55 INFO - TEST-INFO | started process 20713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYPAs4O/profile http://localhost:53224/getInfo.html) 09:08:59 INFO - PROCESS | 20713 | __metrics Screen width/height:1600/1200 09:08:59 INFO - PROCESS | 20713 | colorDepth:24 09:08:59 INFO - PROCESS | 20713 | Browser inner width/height: 1024/697 09:08:59 INFO - PROCESS | 20713 | __metrics 09:09:00 ERROR - PROCESS | 20713 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:09:00 INFO - TEST-INFO | 20713: exit 0 09:09:00 INFO - Browser initialized. 09:09:00 INFO - Running cycle 1/1 for kraken test... 09:09:00 INFO - TEST-INFO | started process 20795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYPAs4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:12 INFO - PROCESS | 20795 | RSS: Main: 152866816 09:09:12 INFO - PROCESS | 20795 | 09:09:15 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:16 INFO - PROCESS | 20795 | RSS: Main: 209129472 09:09:16 INFO - PROCESS | 20795 | 09:09:19 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-dft) 09:09:19 INFO - PROCESS | 20795 | RSS: Main: 197726208 09:09:19 INFO - PROCESS | 20795 | 09:09:22 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-fft) 09:09:23 INFO - PROCESS | 20795 | RSS: Main: 265605120 09:09:23 INFO - PROCESS | 20795 | 09:09:25 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53224/tests/kraken/driver.html?testName=audio-oscillator) 09:09:26 INFO - PROCESS | 20795 | RSS: Main: 174858240 09:09:26 INFO - PROCESS | 20795 | 09:09:28 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:29 INFO - PROCESS | 20795 | RSS: Main: 179154944 09:09:29 INFO - PROCESS | 20795 | 09:09:32 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:32 INFO - PROCESS | 20795 | RSS: Main: 215220224 09:09:32 INFO - PROCESS | 20795 | 09:09:36 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53224/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:37 INFO - PROCESS | 20795 | RSS: Main: 212836352 09:09:37 INFO - PROCESS | 20795 | 09:09:40 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53224/tests/kraken/driver.html?testName=json-parse-financial) 09:09:40 INFO - PROCESS | 20795 | RSS: Main: 213528576 09:09:40 INFO - PROCESS | 20795 | 09:09:42 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:42 INFO - PROCESS | 20795 | RSS: Main: 204914688 09:09:42 INFO - PROCESS | 20795 | 09:09:44 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:45 INFO - PROCESS | 20795 | RSS: Main: 209833984 09:09:45 INFO - PROCESS | 20795 | 09:09:47 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:48 INFO - PROCESS | 20795 | RSS: Main: 218112000 09:09:48 INFO - PROCESS | 20795 | 09:09:50 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:51 INFO - PROCESS | 20795 | RSS: Main: 224092160 09:09:51 INFO - PROCESS | 20795 | 09:09:54 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:54 INFO - PROCESS | 20795 | RSS: Main: 221155328 09:09:54 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:53224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53224/tests/kraken/driver.html?testName=ai-astar) 09:09:56 INFO - PROCESS | 20795 | RSS: Main: 266625024 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | __start_tp_report 09:09:56 INFO - PROCESS | 20795 | _x_x_mozilla_page_load 09:09:56 INFO - PROCESS | 20795 | _x_x_mozilla_page_load_details 09:09:56 INFO - PROCESS | 20795 | |i|pagename|runs| 09:09:56 INFO - PROCESS | 20795 | |0;ai-astar;110;104;109;109;112;110;109;111;110;110 09:09:56 INFO - PROCESS | 20795 | |1;audio-beat-detection;162;123;151;213;133;146;150;128;176;130 09:09:56 INFO - PROCESS | 20795 | |2;audio-dft;162;162;160;163;160;160;161;161;160;161 09:09:56 INFO - PROCESS | 20795 | |3;audio-fft;74;76;75;158;75;75;75;74;131;76 09:09:56 INFO - PROCESS | 20795 | |4;audio-oscillator;91;92;151;92;91;91;122;91;92;120 09:09:56 INFO - PROCESS | 20795 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;117;116;117 09:09:56 INFO - PROCESS | 20795 | |6;imaging-darkroom;146;145;145;145;145;145;145;147;147;145 09:09:56 INFO - PROCESS | 20795 | |7;imaging-desaturate;94;95;94;94;94;95;95;95;94;94 09:09:56 INFO - PROCESS | 20795 | |8;json-parse-financial;56;53;56;54;54;55;56;107;53;53 09:09:56 INFO - PROCESS | 20795 | |9;json-stringify-tinderbox;58;59;58;59;58;58;61;60;62;62 09:09:56 INFO - PROCESS | 20795 | |10;stanford-crypto-aes;81;84;78;76;77;79;78;88;79;79 09:09:56 INFO - PROCESS | 20795 | |11;stanford-crypto-ccm;121;122;120;126;120;119;122;119;185;137 09:09:56 INFO - PROCESS | 20795 | |12;stanford-crypto-pbkdf2;161;159;158;156;157;161;161;157;155;159 09:09:56 INFO - PROCESS | 20795 | |13;stanford-crypto-sha256-iterative;62;63;63;67;64;61;63;66;61;62 09:09:56 INFO - PROCESS | 20795 | __end_tp_report 09:09:56 INFO - PROCESS | 20795 | __start_cc_report 09:09:56 INFO - PROCESS | 20795 | _x_x_mozilla_cycle_collect,1899 09:09:56 INFO - PROCESS | 20795 | __end_cc_report 09:09:56 INFO - PROCESS | 20795 | __startTimestamp1463501396659__endTimestamp 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | ------- Summary: start ------- 09:09:56 INFO - PROCESS | 20795 | Number of tests: 14 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 09:09:56 INFO - PROCESS | 20795 | Values: 110.0 104.0 109.0 109.0 112.0 110.0 109.0 111.0 110.0 110.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:150.50 stddev:27.27 (18.1%) stddev-sans-first:28.64 09:09:56 INFO - PROCESS | 20795 | Values: 162.0 123.0 151.0 213.0 133.0 146.0 150.0 128.0 176.0 130.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:09:56 INFO - PROCESS | 20795 | Values: 162.0 162.0 160.0 163.0 160.0 160.0 161.0 161.0 160.0 161.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:29.99 (40.0%) stddev-sans-first:31.33 09:09:56 INFO - PROCESS | 20795 | Values: 74.0 76.0 75.0 158.0 75.0 75.0 75.0 74.0 131.0 76.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:91.00 stddev:20.80 (22.9%) stddev-sans-first:21.58 09:09:56 INFO - PROCESS | 20795 | Values: 91.0 92.0 151.0 92.0 91.0 91.0 122.0 91.0 92.0 120.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:09:56 INFO - PROCESS | 20795 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 09:09:56 INFO - PROCESS | 20795 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 147.0 147.0 145.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:09:56 INFO - PROCESS | 20795 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:54.50 stddev:16.67 (30.6%) stddev-sans-first:17.62 09:09:56 INFO - PROCESS | 20795 | Values: 56.0 53.0 56.0 54.0 54.0 55.0 56.0 107.0 53.0 53.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:1.65 (2.8%) stddev-sans-first:1.66 09:09:56 INFO - PROCESS | 20795 | Values: 58.0 59.0 58.0 59.0 58.0 58.0 61.0 60.0 62.0 62.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:3.60 (4.6%) stddev-sans-first:3.80 09:09:56 INFO - PROCESS | 20795 | Values: 81.0 84.0 78.0 76.0 77.0 79.0 78.0 88.0 79.0 79.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:122.00 stddev:20.37 (16.7%) stddev-sans-first:21.39 09:09:56 INFO - PROCESS | 20795 | Values: 121.0 122.0 120.0 126.0 120.0 119.0 122.0 119.0 185.0 137.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:2.17 (1.4%) stddev-sans-first:2.09 09:09:56 INFO - PROCESS | 20795 | Values: 161.0 159.0 158.0 156.0 157.0 161.0 161.0 157.0 155.0 159.0 09:09:56 INFO - PROCESS | 20795 | 09:09:56 INFO - PROCESS | 20795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.99 (3.2%) stddev-sans-first:2.06 09:09:56 INFO - PROCESS | 20795 | Values: 62.0 63.0 63.0 67.0 64.0 61.0 63.0 66.0 61.0 62.0 09:09:56 INFO - PROCESS | 20795 | -------- Summary: end -------- 09:09:56 INFO - PROCESS | 20795 | 09:09:57 INFO - TEST-INFO | 20795: exit 0 09:09:57 INFO - TEST-OK | kraken | took 62146ms 09:09:57 INFO - SUITE-END | took 1174s 09:09:57 INFO - Completed test suite (00:19:34) 09:09:57 INFO - javascript benchmark 09:09:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.924605634084, 3165.145410739102, 3193.1538142392264, 3204.759643026771, 3228.015455286138, 5303.867403314919, 5326.973365133169, 5356.839294821152, 5385.380681221661, 5393.81121660742, 5357.223202635615, 5375.462453754622, 5375.973120134404, 5399.271098401715, 5421.810236641718, 4885.267209918523, 4950.084234416627, 4965.528274813905, 4975.925361119586, 5166.819161329354, 5063.518965698253, 5071.442141364447, 5099.388073431175, 5130.4356520782685, 5139.203423469349, 4852.0, 4891.559759621651, 4892.0705066037335, 4933.235348520985, 4979.302897594322, 4844.176489996709, 4871.342368780205, 4947.455779864212, 4962.255661650745, 4994.800207991676, 4830.806767729287, 4924.630652701026, 4940.851774446773, 4953.554180123806, 4970.552650261494, 5333.573314134898, 5374.193870919355, 5394.973025134849, 5434.809781657623, 5448.073827449343, 5858.794942177046, 5866.76532938682, 5885.911711324334, 5889.882202355929, 5918.201042859245, 5694.032014557535, 5734.311882574076, 5734.684592347419, 5849.6197747146725, 5879.559033072494, 5437.864053398657, 5466.316710411199, 5477.04151773442, 5478.534324582375, 5484.91772623411, 5941.22764040672, 5949.315828679671, 5950.851228719317, 5952.0, 5954.434328738849, 5487.807926722546, 5670.914936275959, 5710.885782284331, 5722.456366645245, 5736.77052917887, 5815.447532484407, 5829.621074630136, 5838.211841401441, 5887.646741195542, 5891.3224979127945, 5811.244538210006, 5812.9709351452975, 5814.622049566765, 5818.185454036438, 5822.359540450547, 5625.0, 5755.539556835443, 5821.854453638693, 5844.503217226498, 5886.23478947734, 4433.778311084498, 4443.244648409778, 4447.755373454491, 4450.554944505524, 4491.416115904912, 3847.076701591598, 3964.7224694271126, 3995.081131339808, 4019.0957034666967, 4062.8171732272117, 5474.206240095164, 5517.337919449692, 5537.612367134342, 5565.053940830068, 5585.804496842591, 5927.2590926134235, 5928.970355148283, 5929.851753706192, 5936.28764548257, 5939.406059394112, 5290.206469029677, 5439.619226654097, 5554.0, 5567.331920169525, 5569.470900264469, 4991.850244492598, 5004.524570165829, 5028.044671512401, 5045.268436076748, 5066.265391518209, 6089.695515224221, 6097.878042439215, 6104.542159338067, 6105.175801266861, 6117.663528505975, 5634.23937768396, 5785.30576330843, 5807.535397168132, 5859.794907178229, 5874.353821079763, 5986.431289027535, 6064.4541991221, 6065.332813390612, 6069.817905462844, 6099.298580663103, 5703.45817147387, 5726.9713651431475, 5748.051571490657, 5755.1367294906095, 5755.482006619424, 5601.047821870373, 5778.133280008033, 5804.245448091721, 5811.302643682785, 5832.212651292191, 5720.313562372542, 5720.742566584597, 5725.7137143141845, 5727.799527016535, 5730.742116604846, 5635.746391412478, 5669.234653321749, 5681.176229446624, 5705.0, 5718.285214348207, 5413.052715774802, 5472.370677372153, 5494.670319780826, 5548.805791797267, 5585.553155747449, 5667.40492248308, 5669.461401166883, 5722.399148089391, 5731.398203188605, 5756.65460072397, 5506.476884695948, 5515.448455154613, 5554.444555544414, 5558.555315574825, 5604.019296623156], "value": 5365.743443944648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2584269662922, 628.6605233174087, 633.547013885072, 648.6043513456791, 657.4608820766973, 42951.0, 44120.779396102975, 44194.0, 44202.0, 47476.0504789904, 45803.0, 46223.30665040027, 46353.7682311588, 46358.76820615892, 46381.53618463814, 8935.91064089359, 9069.909300907006, 9074.36479446439, 9079.500627465486, 9081.273498120168, 8978.057303983085, 9055.275577953747, 9074.455532668027, 9080.727578172666, 9086.772830679252, 9159.725208243763, 9208.309376796733, 9208.861867071999, 9212.953935230315, 9216.078392160764, 9101.544922753836, 9103.271738260923, 9121.315901307395, 9137.451752894847, 9155.587998540082, 8845.469271843709, 8912.0, 8918.687845925426, 8924.553772311423, 8931.73204803857, 42079.36880946788, 42366.78816605928, 42445.36331955023, 42467.36298955518, 42537.36193957093, 3416.180116771982, 3468.3410152071024, 3516.0682419158943, 3550.4851796489625, 4065.8780236592947, 31848.6815131848, 32340.0, 32530.349393012242, 32545.837270813732, 33661.15847103842, 4209.515905670826, 4223.514295855985, 4251.80866860992, 4268.637165840907, 4325.956740432587, 325146.0, 325857.0, 326187.36906315555, 326409.0, 326985.0, 54350.0, 60490.39509604847, 61385.69307153525, 61525.69237153786, 61531.0, 62519.374806252265, 63045.369546304864, 63464.0, 69653.65173174204, 69968.30031699719, 15585.844141558438, 15690.0, 15709.528714138594, 15722.449714259947, 15728.68542629141, 11968.222065565711, 12176.878231217574, 12996.545120920722, 13099.345032748515, 13119.147255428366, 18169.36407225741, 18497.167627456798, 18559.0, 19178.424647260603, 19439.90280048619, 6542.345765423514, 6812.080369150101, 6839.110915580943, 6864.107666003488, 6872.450203983669, 943.8065196634674, 1072.383379556758, 1109.839073334362, 1120.3389999899935, 1180.0087926142082, 33885.0, 33934.32131357359, 34297.0, 34595.859048377264, 34790.82604586961, 1118.7147277444362, 1161.6689243565543, 1171.666075168573, 1174.8237764335418, 1176.4941075337515, 17151.571210719583, 18044.548886277684, 18073.45779626613, 18106.909465452587, 18175.272989080553, 511907.0, 512432.0, 512490.0, 516231.0, 520440.0, 56074.0, 57430.69269804782, 57500.0, 57542.42457575371, 57608.71195644079, 1266.6769973656658, 1287.575100216926, 1369.0895554456174, 1402.4320150338924, 1405.1990365491572, 32700.83649581737, 35259.0, 35303.47044794279, 35335.46996794999, 35524.111897202776, 51250.23124653208, 51415.74292128516, 51918.0, 51962.220566690776, 51995.2200716982, 384355.0, 385369.0, 385385.0, 387862.0, 388834.0, 34737.82631086929, 42318.999451891716, 43251.0, 46437.76781116073, 46624.76687616676, 49229.261561075895, 49266.75366623144, 49698.254526182856, 49724.751376242886, 49848.25227621661, 40419.595804041586, 41462.79268603637, 41587.37618935779, 41746.0, 42635.57364426316, 41001.79499102486, 41453.58546414497, 41980.58019419889, 42712.14575708531, 42768.14463710646, 42094.36858447187, 42209.36685949775, 42402.15195696007, 43217.135657286046, 43581.0, 36544.0, 37124.25751485009, 37380.81309593435, 37575.0, 37935.24129517449, 28960.855195723885, 28971.5654265182, 29333.70666293395, 29353.412931741674, 29451.263718406353], "value": 20608.898098252215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.2934324201572, 399.6123759952845, 400.6614410822855, 400.8977710683776, 412.65337116821865, 12929.167037597563, 19261.807381926177, 19396.70904936427, 20085.799142008593, 20098.49753756157, 14678.779818302733, 16584.751228731548, 18212.63574728508, 18347.35784247548, 18633.0, 5574.637648552841, 5690.772369105231, 5707.743151558169, 5717.514011309044, 5739.139129130622, 5608.495235428811, 5724.570657200706, 5764.567657425689, 5764.7982320618785, 5769.971150144243, 4031.475908131939, 5608.971955140239, 5910.0, 6215.720292586844, 6219.067139929024, 6197.504199664061, 6273.404026617464, 6274.466670333004, 6301.495880329586, 6317.905231421532, 5496.258005169291, 5609.859753506195, 5633.887322253573, 5636.126400407943, 5637.71811409432, 21981.67027494589, 21983.120675172973, 22602.660960085614, 22613.0, 22969.42576435586, 2428.417179876817, 2757.7793776497833, 3166.4617015107488, 3182.474891642876, 3201.695838895301, 13878.167309961435, 14007.719845603031, 14070.85929140716, 14345.71308573833, 14672.193029383487, 1969.4682435742413, 1973.822355987968, 1984.1765667248076, 1989.433011591704, 2027.7566691996908, 79116.20883791204, 79409.60295198545, 81018.59490702568, 81651.0, 82768.58615706943, 10646.787064258671, 10790.67627971162, 10818.0, 10917.672469825919, 11031.613893513688, 15188.696226075417, 15222.46721364747, 15225.238738063052, 15249.0, 15302.387904483918, 7819.609019549113, 7883.645235964395, 8000.199980001953, 8094.231048050426, 8124.22819832115, 7459.925400745923, 7609.440064786705, 7637.15991240963, 7676.654550545239, 7719.343855772322, 5847.298324201123, 6154.692265386713, 6703.798886033329, 6721.66391680414, 6825.146856642919, 1830.8908217165035, 1962.4603234110734, 1988.4829944214318, 1991.392625249313, 2018.64673682108, 959.7984423271051, 1041.6926010944646, 1080.0865262686727, 1080.8108580998294, 1114.5876025870318, 19084.14121364542, 19427.4171774847, 19464.513387165433, 19497.610047798964, 19820.60358792816, 1041.1514615588271, 1046.3669479964665, 1070.82866741321, 1092.1617235646163, 1136.9147313951487, 10361.844572331422, 11337.829932551018, 11397.487113079931, 11419.714507137389, 11423.086153107732, 355304.0, 363678.0, 365418.0, 460934.0, 481055.0, 91844.0, 96730.51634741781, 97197.5140124309, 97412.51293743486, 97735.51132244294, 1033.1424917318607, 1065.5471424644495, 1066.3282132256784, 1069.3744159666526, 1076.1552181537456, 16343.754843677116, 17390.391336303168, 17462.563435914202, 17647.117644117487, 17757.0, 37400.0, 38774.0, 39385.80307098446, 39438.80280598579, 40542.0, 54354.72822635862, 56980.14529782139, 57286.42713572811, 57616.135757962824, 57806.71096644658, 7602.391808655184, 7997.680092796456, 8487.27858132041, 8567.186117318844, 8608.741737747878, 13126.343682816012, 13269.668258293234, 13326.733465330833, 13450.86549134496, 13660.316984150952, 11872.347020913587, 12057.276563406223, 12249.142560020713, 12277.447514862031, 12288.692782680504, 11719.941400292944, 12068.879311206776, 12123.0, 12147.0, 12311.876881231432, 12258.509659613872, 12399.75200496003, 12405.75188496243, 12522.123451358317, 12532.185407948455, 7645.770626881203, 8013.759587212393, 8097.757067287991, 8195.67217311301, 8227.218414250636, 9300.813983720152, 11505.539778408769, 12235.510579577074, 12298.385080746106, 12342.938285308515], "value": 9417.459151904326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.483818568037, 1549.2563569486642, 1557.5794535475418, 1760.2518929454986, 1889.272630037436, 8623.956880215597, 9006.639734410632, 9015.0, 9276.721698349043, 9305.906940930605, 9030.187283144516, 9249.491277979709, 9250.67622633208, 9264.0, 9265.861012084808, 2096.5806838632257, 2163.610550100981, 2167.6531754919215, 2374.287713685896, 2401.86789726565, 2375.501144759594, 2456.435019945414, 2457.9016839326405, 2465.3713303107684, 2470.147799009339, 2395.197608801054, 2400.1839374612628, 2403.51929614077, 2404.8076153907646, 2440.048381131351, 2021.3733742539712, 2317.2121478697154, 2391.390195500154, 2423.9515209695796, 2424.612062070078, 2386.2602593195993, 2420.4190994161277, 2422.987885060581, 2426.5146970605774, 2427.5751743444825, 8848.911510884938, 8864.8670269946, 8919.821603567958, 8920.598573064228, 8925.33060020501, 5205.453427390145, 5358.973205133989, 5374.543163831079, 5384.515393614554, 5393.973030134864, 3372.8988130355883, 3380.6281309055985, 3544.85820567177, 3556.022093924166, 3567.4470457079196, 1126.4761885723096, 1157.2940506291156, 1180.9763804723943, 1196.114874992508, 1196.5871774237874, 12998.480060797652, 13010.154339967967, 13017.21896686202, 13025.088243822936, 13034.739305213843, 4844.8304309349005, 4857.0, 4921.089598424303, 4922.704637721748, 4927.852164435073, 10993.725156871142, 11031.779364412667, 11062.170337224741, 11064.889351106547, 11067.778644427228, 5385.192221166856, 5438.564914806806, 5449.155380915964, 5452.700101494376, 5458.235846981426, 4892.046051020017, 4962.03240368132, 4994.675346102492, 5012.7994880205115, 5028.547430731252, 3792.355299599075, 3857.8071096445065, 3895.7662540247675, 3914.784686842194, 3951.4270430787374, 1163.7323415614455, 1180.2151569206553, 1185.2947496239724, 1186.9703257418635, 1196.0969468051564, 1014.2342531388754, 1022.1822541966397, 1036.2021243642353, 1045.6706137566794, 1053.7365658585354, 6291.591046581958, 6326.68366581669, 6355.3644635537, 6366.140571022853, 6503.349665033459, 459.69889722231994, 459.87353477793874, 465.25326850405287, 1049.2497864027257, 1137.3176094343328, 4059.918801623951, 4156.688248381383, 4274.615284624399, 4314.654827613784, 4337.848175313912, 11274.098072154207, 11489.827652585218, 11650.475728592233, 11663.533458661559, 11678.708032299091, 11498.540058397737, 11543.538258469735, 11552.826707599394, 11581.652550423501, 11594.942025289989, 7938.761837144895, 8298.170182981774, 8359.289460395934, 8370.0, 8501.744947651581, 6386.201724784402, 6515.250746164252, 6593.307702691149, 6613.2394774601535, 6628.436582890508, 10555.261131720707, 10657.946710266398, 10698.197635177237, 10797.082248009006, 10804.189685773441, 9796.608135674493, 9994.20046396272, 10601.0, 10911.83632245501, 10956.671299860698, 8222.876656850272, 8269.751907442786, 8440.240378365976, 8464.153584641734, 8498.660053598034, 8854.690085846965, 8994.235489983424, 8994.865077023718, 9001.279897608307, 9005.729828105168, 7848.686052557834, 8242.917570824215, 8253.83492330162, 8359.289460395692, 8381.16188381157, 7744.186860379805, 7799.805004874924, 7901.328387087162, 8081.83836323282, 8104.959475202586, 7143.9285607143265, 7154.534955227893, 7396.815079623052, 7398.704051837866, 7399.963000184965, 5419.566434685295, 5495.780168793203, 5501.367342755634, 5514.558835293086, 5613.522850557748, 5409.78360865561, 5458.672479651074, 5492.093804522209, 5562.276904002454, 5666.490015898589], "value": 4784.748136668181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9486482162853, 325.3639135490117, 332.5593588495243, 332.9246533696161, 336.0339025302256, 5290.8412747617585, 5345.492178243061, 5354.437784032674, 5403.78384864605, 5422.539084177844, 5208.374995000605, 5253.343332083489, 5290.444503327153, 5291.6031297652635, 5323.973380133104, 4177.7493350399, 4190.601892820177, 4190.889414305211, 4216.47294088239, 4221.641160501345, 4009.3184158693093, 4088.5281298732434, 4194.517630472489, 4216.5572614875455, 4216.891554222889, 4152.875413737577, 4157.771322577257, 4164.625183733463, 4183.477065366829, 4192.685548583853, 4030.496187976503, 4128.298189307825, 4171.0, 4181.853635122771, 4205.432266643995, 3644.416893297086, 3733.663970242691, 3749.531308586427, 3756.211195648917, 3761.1913438610554, 5121.975604879002, 5140.049090918154, 5161.896762064775, 5181.222816577506, 5181.430042695338, 4606.884827879297, 4738.644601654855, 4764.523547645243, 4805.279208118775, 4829.830955916561, 5540.168974653794, 5544.61187716856, 5560.888782224333, 5562.969516126625, 5567.248421463091, 4083.734557253799, 4090.8363665453644, 4103.9179216415805, 4110.321796903508, 4170.061736109351, 5619.381867994517, 5695.686737229492, 5761.48146666802, 5773.797917072882, 5789.710514474259, 4194.741577526791, 4195.790210489463, 4197.937030944478, 4199.874003779892, 4209.389638502461, 4265.658747300208, 4271.060366719316, 4283.828646854154, 4294.806733696991, 4297.72064815786, 4807.903841923142, 4822.68652537584, 4856.587190088811, 4861.0, 4865.732384718804, 5375.19372094189, 5603.534444844256, 5612.550995920316, 5615.213870058195, 5636.887262254814, 1423.8789702875372, 1444.8699617034517, 1445.6096853849401, 1456.6649670575828, 1460.889723809891, 864.9048604653483, 906.7506435730095, 915.2815040193416, 918.8376703470116, 924.2900633827365, 4827.348307978448, 5174.508421699932, 5298.92051619226, 5383.757730902119, 5413.675179489243, 5682.346530149003, 5691.743871525791, 5722.713864306768, 5745.511631511368, 5771.105478650816, 5212.0, 5378.1663842104535, 5390.838274851761, 5414.972925135428, 5426.321709786277, 2989.536621823577, 2989.7309242168308, 3003.294225856922, 3019.818810871355, 3053.206166396753, 5811.198528456108, 5874.9118763218585, 5875.794347197828, 5900.911486327708, 5904.881902362014, 5706.514946229617, 5716.685582292931, 5855.531557475391, 5870.73581688825, 5886.02755608415, 5853.4731874132385, 5853.531717462678, 5897.174395584621, 5904.734286957183, 5955.940440595626, 5483.643563168382, 5723.6851973141875, 5726.828195154152, 5735.8852822944145, 5750.7987220447085, 5606.383297837317, 5633.6619802811965, 5641.37944826077, 5642.60501764889, 5661.207430959586, 5899.351071382059, 5913.013927966522, 5914.349421563538, 5918.970405147947, 5926.377730338252, 3890.4942357493346, 4111.876643700693, 4131.586841315844, 4131.731437456556, 4131.938020929749, 5645.125005624135, 5671.234383358194, 5732.942670573241, 5748.712564371848, 5763.366029736641, 5519.917201242065, 5525.834224973097, 5576.302962129734, 5600.635958662674, 5625.606207565431, 5337.546308563816, 5533.3083364579425, 5534.1975413564005, 5545.694986775605, 5546.639468434539, 5435.456454354533, 5459.727013649381, 5466.699331536644, 5469.507744303032, 5506.311711036121, 5394.676319420691, 5443.802363480028, 5623.156526521055, 5623.629433890706, 5652.180433836988, 5479.0, 5490.5882058844945, 5496.642718223303, 5499.9100341871435, 5500.724963751876], "value": 4262.858391952247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.9431639785215, 819.3527113580271, 855.1106848877164, 858.729500207435, 863.7106569299284, 14370.49703260386, 15210.0, 15380.615484612876, 15411.306491207895, 15432.69134617307, 14037.36831842567, 14097.365618547165, 14100.0, 14102.788458173136, 14110.929445352758, 706.4701473894579, 812.553095797312, 829.8049958259804, 832.4006715165086, 835.9665613375457, 836.5440834745048, 838.0655569040506, 841.4866931172011, 844.7888027993001, 844.923956843884, 901.301491344207, 901.945883247004, 902.8104098139365, 902.8149229407956, 903.3766700976305, 747.7495039161887, 872.1714371347214, 896.601012549419, 897.582624079806, 900.3652425040331, 651.2152855808787, 651.820749293948, 652.1749986267375, 652.2433976587183, 652.3052948609762, 14255.714885702331, 14328.85671143296, 14347.354369053417, 14379.640508987255, 14381.856181438156, 13500.729985400238, 13615.863841361657, 13734.903831817464, 13736.65658358539, 13843.169409835442, 11827.645170644895, 11829.881701182963, 11920.225185362924, 11946.28322300656, 12007.699807504794, 4360.869173924787, 4415.4259946206785, 4434.401355816955, 4538.410006699108, 4550.817967281305, 53181.46818531804, 53302.200466993025, 53340.73329633327, 53667.0, 53868.730656346466, 11045.226834121695, 11125.109991200685, 11131.053860421955, 11230.7192320191, 11730.0, 19182.328618498286, 19223.423297301102, 19226.654134210752, 19230.423087307405, 19241.615167696567, 7910.0, 8169.795755106051, 8357.707480238285, 8601.483910965362, 8713.433626814236, 4576.839810606612, 4610.492845786961, 4611.377464042312, 4612.7001744886475, 4781.187198176319, 3430.485427185942, 3516.6483351665142, 3517.8065206413894, 3521.5774107107313, 3522.5772907251294, 539.9541039011649, 654.2933631677777, 655.0926966151914, 660.1517050589969, 694.0179645801135, 753.4800987318732, 770.0123520739495, 784.0395515493475, 804.5977011494252, 812.4069429316633, 9861.767279090114, 10598.523066462029, 10607.787844243072, 10642.361458312525, 10683.626073087406, 691.9411849992807, 709.2340272505785, 730.3499885102264, 740.9962950185214, 764.289211033744, 4815.181419158752, 4906.705597664151, 4915.85033878431, 5012.1980483122525, 5017.523335283142, 72326.27673723195, 74244.62877685577, 75537.0, 75986.62006689931, 76360.23639763643, 66829.33170668328, 66861.0, 67135.0, 68621.31378686249, 69063.0, 55269.44730552723, 56118.15822762662, 56151.71924140353, 60615.69692151511, 61612.0, 9758.951205243928, 9832.852507212541, 10210.744731381776, 10281.0, 10290.948545257525, 36589.81705091458, 36671.449928250564, 37437.2512549742, 37837.918914459966, 38649.22701545897, 46725.76637116793, 49463.50536494589, 49893.75053124711, 50690.23964640607, 51830.74084629553, 12394.194377365802, 12564.120511564102, 12584.937075314565, 13106.60680179596, 13207.60377188686, 13951.581452556033, 14861.554153375417, 14869.323521766186, 15194.696106078038, 15390.0, 13819.723605527632, 14171.929140354645, 14627.268636567916, 14650.340734666752, 14742.2628868554, 13325.800112998506, 13841.307934603028, 14099.0, 14208.857911420753, 14313.785293220402, 13461.528846490326, 13697.109687870257, 14295.356708947915, 14313.141211527342, 14399.136051836924, 11420.428978551205, 11474.598389056342, 11659.417029148339, 11680.824787628362, 11902.821457678316, 10834.241603087708, 11065.391403472886, 11077.667669969915, 11143.498542565441, 11214.551417943518], "value": 7199.776562816765, "unit": "score"}], "name": "dromaeo_css", "value": 7312.912281793472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 109.0, 112.0, 110.0, 109.0, 111.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 151.0, 213.0, 133.0, 146.0, 150.0, 128.0, 176.0, 130.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 163.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 158.0, 75.0, 75.0, 75.0, 74.0, 131.0, 76.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 151.0, 92.0, 91.0, 91.0, 122.0, 91.0, 92.0, 120.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 147.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 56.0, 54.0, 54.0, 55.0, 56.0, 107.0, 53.0, 53.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 61.0, 60.0, 62.0, 62.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 78.0, 76.0, 77.0, 79.0, 78.0, 88.0, 79.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 120.0, 126.0, 120.0, 119.0, 122.0, 119.0, 185.0, 137.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 158.0, 156.0, 157.0, 161.0, 161.0, 157.0, 155.0, 159.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 67.0, 64.0, 61.0, 63.0, 66.0, 61.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1520.1000000000001, "alertThreshold": 2.0}]} 09:09:57 INFO - Return code: 0 09:09:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:09:57 ERROR - # TBPL SUCCESS # 09:09:57 INFO - Running post-action listener: _resource_record_post_action 09:09:57 INFO - ##### 09:09:57 INFO - ##### Finished run-tests step (success) 09:09:57 INFO - ##### 09:09:57 INFO - Running post-run listener: _resource_record_post_run 09:09:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537444352; Read time: 8; Write time: 452996 09:09:58 INFO - TinderboxPrint: CPU usage
13.1% 09:09:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:09:58 INFO - TinderboxPrint: I/O write bytes / time
537,444,352 / 452,996 09:09:58 INFO - TinderboxPrint: CPU idle
8,269.6 (86.9%) 09:09:58 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 09:09:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:09:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246480896; Read time: 0; Write time: 268260 09:09:58 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290832384; Read time: 8; Write time: 184736 09:09:58 INFO - Running post-run listener: _upload_blobber_files 09:09:58 INFO - Blob upload gear active. 09:09:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:09:58 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'] 09:09:58 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 09:09:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:59 INFO - (blobuploader) - INFO - Done attempting. 09:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:03 INFO - (blobuploader) - INFO - Done attempting. 09:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:04 INFO - (blobuploader) - INFO - Done attempting. 09:10:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:04 INFO - Return code: 0 09:10:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a30f4ff87e96f174b4cbe5b3caf5e2a580a9887b37f83eef35b0d7f866d66b60d1c98d659c9d69df92958b18e93f4229a97f971113b21c716ef7edf0de3f9558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/773b6cc354a9ae74d05917cdeaac042b84e38378cd930b666b852cab69e9166032450c14d6c6eedb5ec5c8e506cf1a43e2a2710a998c03b708f4b7b5117bdea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7909358b5ea569ef17eba6ff866ebb97847f6ad6220469330b728937874ba393f7ae2676e0624efe0aa062be2e623af3ea26401f1fd6353a061db02263104f6f"} 09:10:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:04 INFO - Contents: 09:10:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a30f4ff87e96f174b4cbe5b3caf5e2a580a9887b37f83eef35b0d7f866d66b60d1c98d659c9d69df92958b18e93f4229a97f971113b21c716ef7edf0de3f9558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/773b6cc354a9ae74d05917cdeaac042b84e38378cd930b666b852cab69e9166032450c14d6c6eedb5ec5c8e506cf1a43e2a2710a998c03b708f4b7b5117bdea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7909358b5ea569ef17eba6ff866ebb97847f6ad6220469330b728937874ba393f7ae2676e0624efe0aa062be2e623af3ea26401f1fd6353a061db02263104f6f"} 09:10:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:04 INFO - Copying logs to upload dir... 09:10:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.902842 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-17 09:10:04.593038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 09:10:04.596059) ========= 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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 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/a30f4ff87e96f174b4cbe5b3caf5e2a580a9887b37f83eef35b0d7f866d66b60d1c98d659c9d69df92958b18e93f4229a97f971113b21c716ef7edf0de3f9558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/773b6cc354a9ae74d05917cdeaac042b84e38378cd930b666b852cab69e9166032450c14d6c6eedb5ec5c8e506cf1a43e2a2710a998c03b708f4b7b5117bdea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7909358b5ea569ef17eba6ff866ebb97847f6ad6220469330b728937874ba393f7ae2676e0624efe0aa062be2e623af3ea26401f1fd6353a061db02263104f6f"} build_url:https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/GM5cNMCiSdCgJIjUCXRH0A/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/a30f4ff87e96f174b4cbe5b3caf5e2a580a9887b37f83eef35b0d7f866d66b60d1c98d659c9d69df92958b18e93f4229a97f971113b21c716ef7edf0de3f9558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/773b6cc354a9ae74d05917cdeaac042b84e38378cd930b666b852cab69e9166032450c14d6c6eedb5ec5c8e506cf1a43e2a2710a998c03b708f4b7b5117bdea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7909358b5ea569ef17eba6ff866ebb97847f6ad6220469330b728937874ba393f7ae2676e0624efe0aa062be2e623af3ea26401f1fd6353a061db02263104f6f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 09:10:04.620231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 09:10:04.620538) ========= 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=923d835db2ba3686ebe126b700000192-1463500168.992174-80922534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 09:10:04.704970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 09:10:04.705308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 09:10:04.705586) ========= ========= Total master_lag: 0.16 =========