builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1464081422.96 results: success (0) buildid: 20160523233014 builduid: b267b92b173047feb42fdbf6f94c9c16 revision: a35738e12eb382c6181c530b00b814d72c7a1b7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:02.962088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:02.962562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:02.962859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:02.979316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:02.979699) ========= 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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 02:17:03-- 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% 50.9M=0s 2016-05-24 02:17:03 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:03.144305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:03.144617) ========= 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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014416 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:03.193456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 02:17:03.193813) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a35738e12eb382c6181c530b00b814d72c7a1b7b --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 a35738e12eb382c6181c530b00b814d72c7a1b7b --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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 02:17:03,503 truncating revision to first 12 chars 2016-05-24 02:17:03,503 Setting DEBUG logging. 2016-05-24 02:17:03,503 attempt 1/10 2016-05-24 02:17:03,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a35738e12eb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 02:17:04,794 unpacking tar archive at: fx-team-a35738e12eb3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 02:17:04.765687) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:04.766021) ========= script_repo_revision: a35738e12eb382c6181c530b00b814d72c7a1b7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:04.766423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:04.766707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 02:17:04.773016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-24 02:17:04.773399) ========= /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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:05 INFO - MultiFileLogger online at 20160524 02:17:05 in /builds/slave/test 02:17:05 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 02:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:05 INFO - {'append_to_log': False, 02:17:05 INFO - 'base_work_dir': '/builds/slave/test', 02:17:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:05 INFO - 'branch': 'Fx-Team', 02:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:05 INFO - 'config_files': ('talos/linux_config.py',), 02:17:05 INFO - 'default_actions': ('clobber', 02:17:05 INFO - 'read-buildbot-config', 02:17:05 INFO - 'download-and-extract', 02:17:05 INFO - 'populate-webroot', 02:17:05 INFO - 'create-virtualenv', 02:17:05 INFO - 'install', 02:17:05 INFO - 'run-tests'), 02:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:05 INFO - 'download_minidump_stackwalk': True, 02:17:05 INFO - 'download_symbols': 'ondemand', 02:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:05 INFO - 'installer_path': 'installer.exe', 02:17:05 INFO - 'log_level': 'info', 02:17:05 INFO - 'log_name': 'talos', 02:17:05 INFO - 'log_to_console': True, 02:17:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:05 INFO - 'opt_config_files': (), 02:17:05 INFO - 'pip_index': False, 02:17:05 INFO - 'sps_profile': False, 02:17:05 INFO - 'sps_profile_interval': 0, 02:17:05 INFO - 'suite': 'dromaeojs', 02:17:05 INFO - 'system_bits': '32', 02:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:05 INFO - 'title': 'talos-linux64-ix-065', 02:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:05 INFO - 'use_talos_json': True, 02:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:05 INFO - 'work_dir': 'build'} 02:17:05 INFO - ##### 02:17:05 INFO - ##### Running clobber step. 02:17:05 INFO - ##### 02:17:05 INFO - Running pre-action listener: _resource_record_pre_action 02:17:05 INFO - Running main action method: clobber 02:17:05 INFO - rmtree: /builds/slave/test/build 02:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:06 INFO - Running post-action listener: _resource_record_post_action 02:17:06 INFO - ##### 02:17:06 INFO - ##### Finished clobber step (success) 02:17:06 INFO - ##### 02:17:06 INFO - ##### 02:17:06 INFO - ##### Running read-buildbot-config step. 02:17:06 INFO - ##### 02:17:06 INFO - Running pre-action listener: _resource_record_pre_action 02:17:06 INFO - Running main action method: read_buildbot_config 02:17:06 INFO - Using buildbot properties: 02:17:06 INFO - { 02:17:06 INFO - "project": "", 02:17:06 INFO - "product": "firefox", 02:17:06 INFO - "script_repo_revision": "production", 02:17:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:17:06 INFO - "repository": "", 02:17:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:17:06 INFO - "buildid": "20160523233014", 02:17:06 INFO - "pgo_build": "True", 02:17:06 INFO - "basedir": "/builds/slave/test", 02:17:06 INFO - "buildnumber": 1175, 02:17:06 INFO - "slavename": "talos-linux64-ix-065", 02:17:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:17:06 INFO - "platform": "ubuntu64_hw", 02:17:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:17:06 INFO - "branch": "fx-team", 02:17:06 INFO - "repo_path": "integration/fx-team", 02:17:06 INFO - "revision": "a35738e12eb382c6181c530b00b814d72c7a1b7b", 02:17:06 INFO - "stage_platform": "linux64-pgo", 02:17:06 INFO - "builduid": "b267b92b173047feb42fdbf6f94c9c16", 02:17:06 INFO - "slavebuilddir": "test" 02:17:06 INFO - } 02:17:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:17:06 INFO - Running post-action listener: _resource_record_post_action 02:17:06 INFO - ##### 02:17:06 INFO - ##### Finished read-buildbot-config step (success) 02:17:06 INFO - ##### 02:17:06 INFO - ##### 02:17:06 INFO - ##### Running download-and-extract step. 02:17:06 INFO - ##### 02:17:06 INFO - Running pre-action listener: _resource_record_pre_action 02:17:06 INFO - Running main action method: download_and_extract 02:17:06 INFO - mkdir: /builds/slave/test/build/tests 02:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:06 INFO - https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:06 INFO - Downloaded 1361 bytes. 02:17:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:17:06 INFO - Using the following test package requirements: 02:17:06 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'jsshell-linux-x86_64.zip'], 02:17:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:06 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:06 INFO - https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:07 INFO - Downloaded 24388634 bytes. 02:17:07 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'] 02:17:07 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 02:17:09 INFO - Return code: 0 02:17:09 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 02:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:09 INFO - https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:10 INFO - Downloaded 24388634 bytes. 02:17:10 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'] 02:17:10 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 02:17:11 INFO - Return code: 0 02:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:11 INFO - https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:12 INFO - Downloaded 10840359 bytes. 02:17:12 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'] 02:17:12 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 02:17:12 INFO - Return code: 0 02:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:12 INFO - https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:17:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:17:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:17:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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 02:17:14 INFO - Downloaded 58617131 bytes. 02:17:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:17:14 INFO - mkdir: /builds/slave/test/properties 02:17:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:14 INFO - Contents: 02:17:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:17:15 INFO - Running post-action listener: _resource_record_post_action 02:17:15 INFO - Running post-action listener: set_extra_try_arguments 02:17:15 INFO - ##### 02:17:15 INFO - ##### Finished download-and-extract step (success) 02:17:15 INFO - ##### 02:17:15 INFO - ##### 02:17:15 INFO - ##### Running populate-webroot step. 02:17:15 INFO - ##### 02:17:15 INFO - Running pre-action listener: _resource_record_pre_action 02:17:15 INFO - Running main action method: populate_webroot 02:17:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:17:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:17:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:17:15 INFO - '--tppagecycles', 02:17:15 INFO - '7'], 02:17:15 INFO - 'tests': ['tsvgm']}}, 02:17:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:17:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:17:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:17:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:17:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['damp', 'tps']}, 02:17:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'tests': ['damp', 'tps']}, 02:17:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['dromaeo_dom']}, 02:17:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['a11yr', 02:17:15 INFO - 'ts_paint', 02:17:15 INFO - 'tpaint', 02:17:15 INFO - 'sessionrestore', 02:17:15 INFO - 'sessionrestore_no_auto_restore', 02:17:15 INFO - 'tabpaint']}, 02:17:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['tsvgx', 02:17:15 INFO - 'tsvgr_opacity', 02:17:15 INFO - 'tart', 02:17:15 INFO - 'tscrollx', 02:17:15 INFO - 'cart']}, 02:17:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:17:15 INFO - 'tsvgr_opacity', 02:17:15 INFO - 'tart', 02:17:15 INFO - 'tscrollx', 02:17:15 INFO - 'cart']}, 02:17:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'talos_options': ['--disable-e10s'], 02:17:15 INFO - 'tests': ['tp5o']}, 02:17:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'tests': ['tp5o']}, 02:17:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'talos_options': ['--disable-e10s', 02:17:15 INFO - '--xperf_path', 02:17:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:15 INFO - 'tests': ['tp5n']}, 02:17:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:15 INFO - 'talos_options': ['--xperf_path', 02:17:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:15 INFO - 'tests': ['tp5n']}}, 02:17:15 INFO - 'talos.zip': {'path': '', 02:17:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:17:15 INFO - Running post-action listener: _resource_record_post_action 02:17:15 INFO - ##### 02:17:15 INFO - ##### Finished populate-webroot step (success) 02:17:15 INFO - ##### 02:17:15 INFO - ##### 02:17:15 INFO - ##### Running create-virtualenv step. 02:17:15 INFO - ##### 02:17:15 INFO - Running pre-action listener: _resource_record_pre_action 02:17:15 INFO - Running main action method: create_virtualenv 02:17:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:15 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 02:17:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:17:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:15 INFO - Using real prefix '/usr' 02:17:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:17 INFO - Installing pip.................done. 02:17:17 INFO - Return code: 0 02:17:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17:17 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')]} 02:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 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')]} 02:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:17 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 02:17:17 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 02:17:17 INFO - Using env: {'DISPLAY': ':0', 02:17:17 INFO - 'HOME': '/home/cltbld', 02:17:17 INFO - 'LANG': 'en_US.UTF-8', 02:17:17 INFO - 'LANGUAGE': 'en_US:en', 02:17:17 INFO - 'LOGNAME': 'cltbld', 02:17:17 INFO - 'MAIL': '/var/mail/cltbld', 02:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:17 INFO - 'MOZ_NO_REMOTE': '1', 02:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:17 INFO - 'NO_EM_RESTART': '1', 02:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:17 INFO - 'PWD': '/builds/slave/test', 02:17:17 INFO - 'SHELL': '/bin/bash', 02:17:17 INFO - 'SHLVL': '1', 02:17:17 INFO - 'TERM': 'linux', 02:17:17 INFO - 'TMOUT': '86400', 02:17:17 INFO - 'USER': 'cltbld', 02:17:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:17 INFO - '_': '/tools/buildbot/bin/python'} 02:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:17 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 02:17:17 INFO - Cleaning up... 02:17:17 INFO - Return code: 0 02:17:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:17:17 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')]} 02:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 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')]} 02:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:17 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 02:17:18 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 02:17:18 INFO - Using env: {'DISPLAY': ':0', 02:17:18 INFO - 'HOME': '/home/cltbld', 02:17:18 INFO - 'LANG': 'en_US.UTF-8', 02:17:18 INFO - 'LANGUAGE': 'en_US:en', 02:17:18 INFO - 'LOGNAME': 'cltbld', 02:17:18 INFO - 'MAIL': '/var/mail/cltbld', 02:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:18 INFO - 'MOZ_NO_REMOTE': '1', 02:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:18 INFO - 'NO_EM_RESTART': '1', 02:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:18 INFO - 'PWD': '/builds/slave/test', 02:17:18 INFO - 'SHELL': '/bin/bash', 02:17:18 INFO - 'SHLVL': '1', 02:17:18 INFO - 'TERM': 'linux', 02:17:18 INFO - 'TMOUT': '86400', 02:17:18 INFO - 'USER': 'cltbld', 02:17:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:18 INFO - '_': '/tools/buildbot/bin/python'} 02:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:18 INFO - Downloading/unpacking psutil>=3.1.1 02:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:20 INFO - Installing collected packages: psutil 02:17:20 INFO - Running setup.py install for psutil 02:17:20 INFO - building 'psutil._psutil_linux' extension 02:17:20 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 02:17:20 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 02:17:20 INFO - building 'psutil._psutil_posix' extension 02:17:20 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 02:17:20 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 02:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:20 INFO - Successfully installed psutil 02:17:20 INFO - Cleaning up... 02:17:20 INFO - Return code: 0 02:17:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:17:20 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')]} 02:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:20 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')]} 02:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:20 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:20 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 02:17:20 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 02:17:20 INFO - Using env: {'DISPLAY': ':0', 02:17:20 INFO - 'HOME': '/home/cltbld', 02:17:20 INFO - 'LANG': 'en_US.UTF-8', 02:17:20 INFO - 'LANGUAGE': 'en_US:en', 02:17:20 INFO - 'LOGNAME': 'cltbld', 02:17:20 INFO - 'MAIL': '/var/mail/cltbld', 02:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:20 INFO - 'MOZ_NO_REMOTE': '1', 02:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:20 INFO - 'NO_EM_RESTART': '1', 02:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:20 INFO - 'PWD': '/builds/slave/test', 02:17:20 INFO - 'SHELL': '/bin/bash', 02:17:20 INFO - 'SHLVL': '1', 02:17:20 INFO - 'TERM': 'linux', 02:17:20 INFO - 'TMOUT': '86400', 02:17:20 INFO - 'USER': 'cltbld', 02:17:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:20 INFO - '_': '/tools/buildbot/bin/python'} 02:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:17:20 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 02:17:20 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 02:17:20 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 02:17:20 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 02:17:20 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 02:17:20 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 02:17:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:17:22 INFO - Installing collected packages: mozsystemmonitor 02:17:22 INFO - Running setup.py install for mozsystemmonitor 02:17:22 INFO - Successfully installed mozsystemmonitor 02:17:22 INFO - Cleaning up... 02:17:23 INFO - Return code: 0 02:17:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:17:23 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')]} 02:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:23 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')]} 02:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:23 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:23 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 02:17:23 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 02:17:23 INFO - Using env: {'DISPLAY': ':0', 02:17:23 INFO - 'HOME': '/home/cltbld', 02:17:23 INFO - 'LANG': 'en_US.UTF-8', 02:17:23 INFO - 'LANGUAGE': 'en_US:en', 02:17:23 INFO - 'LOGNAME': 'cltbld', 02:17:23 INFO - 'MAIL': '/var/mail/cltbld', 02:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:23 INFO - 'MOZ_NO_REMOTE': '1', 02:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:23 INFO - 'NO_EM_RESTART': '1', 02:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:23 INFO - 'PWD': '/builds/slave/test', 02:17:23 INFO - 'SHELL': '/bin/bash', 02:17:23 INFO - 'SHLVL': '1', 02:17:23 INFO - 'TERM': 'linux', 02:17:23 INFO - 'TMOUT': '86400', 02:17:23 INFO - 'USER': 'cltbld', 02:17:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:23 INFO - '_': '/tools/buildbot/bin/python'} 02:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:23 INFO - Downloading/unpacking blobuploader==1.2.4 02:17:23 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 02:17:23 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 02:17:23 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 02:17:23 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 02:17:23 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 02:17:23 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 02:17:25 INFO - Downloading blobuploader-1.2.4.tar.gz 02:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:17:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:17:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 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 02:17:25 INFO - Downloading docopt-0.6.1.tar.gz 02:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:17:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:17:25 INFO - Running setup.py install for blobuploader 02:17:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:17:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:17:26 INFO - Running setup.py install for requests 02:17:26 INFO - Running setup.py install for docopt 02:17:26 INFO - Successfully installed blobuploader requests docopt 02:17:26 INFO - Cleaning up... 02:17:26 INFO - Return code: 0 02:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:26 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:26 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 02:17:26 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 02:17:26 INFO - Using env: {'DISPLAY': ':0', 02:17:26 INFO - 'HOME': '/home/cltbld', 02:17:26 INFO - 'LANG': 'en_US.UTF-8', 02:17:26 INFO - 'LANGUAGE': 'en_US:en', 02:17:26 INFO - 'LOGNAME': 'cltbld', 02:17:26 INFO - 'MAIL': '/var/mail/cltbld', 02:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:26 INFO - 'MOZ_NO_REMOTE': '1', 02:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:26 INFO - 'NO_EM_RESTART': '1', 02:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:26 INFO - 'PWD': '/builds/slave/test', 02:17:26 INFO - 'SHELL': '/bin/bash', 02:17:26 INFO - 'SHLVL': '1', 02:17:26 INFO - 'TERM': 'linux', 02:17:26 INFO - 'TMOUT': '86400', 02:17:26 INFO - 'USER': 'cltbld', 02:17:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:26 INFO - '_': '/tools/buildbot/bin/python'} 02:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:17:26 INFO - Running setup.py (path:/tmp/pip-NunO57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:17:26 INFO - Running setup.py (path:/tmp/pip-FUjUhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:17:26 INFO - Running setup.py (path:/tmp/pip-B_t_Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:17:26 INFO - Running setup.py (path:/tmp/pip-SMvjvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:17:27 INFO - Running setup.py (path:/tmp/pip-XwSxdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:17:27 INFO - Running setup.py (path:/tmp/pip-9_xJf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:17:27 INFO - Running setup.py (path:/tmp/pip-cZINdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:17:27 INFO - Running setup.py (path:/tmp/pip-6nmKAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:17:27 INFO - Running setup.py (path:/tmp/pip-hvjrgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:17:27 INFO - Running setup.py (path:/tmp/pip-1RoWtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:17:27 INFO - Running setup.py (path:/tmp/pip-SvmE7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:17:27 INFO - Running setup.py (path:/tmp/pip-Jwtdmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:17:27 INFO - Running setup.py (path:/tmp/pip-vW3xqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:17:27 INFO - Running setup.py (path:/tmp/pip-1AuSYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:27 INFO - Running setup.py (path:/tmp/pip-wOxZ6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:17:27 INFO - Running setup.py (path:/tmp/pip-AVg7nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:17:27 INFO - Running setup.py (path:/tmp/pip-LfZnEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:17:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:17:27 INFO - Running setup.py install for manifestparser 02:17:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for mozcrash 02:17:28 INFO - Running setup.py install for mozdebug 02:17:28 INFO - Running setup.py install for mozdevice 02:17:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for mozfile 02:17:28 INFO - Running setup.py install for mozhttpd 02:17:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for mozinfo 02:17:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for mozInstall 02:17:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for mozleak 02:17:28 INFO - Running setup.py install for mozlog 02:17:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:17:28 INFO - Running setup.py install for moznetwork 02:17:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Running setup.py install for mozprocess 02:17:29 INFO - Running setup.py install for mozprofile 02:17:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Running setup.py install for mozrunner 02:17:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Running setup.py install for mozscreenshot 02:17:29 INFO - Running setup.py install for moztest 02:17:29 INFO - Running setup.py install for mozversion 02:17:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:17:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:17:29 INFO - Cleaning up... 02:17:29 INFO - Return code: 0 02:17:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:29 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')]} 02:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:29 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')]} 02:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:29 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:29 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 02:17:29 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 02:17:29 INFO - Using env: {'DISPLAY': ':0', 02:17:29 INFO - 'HOME': '/home/cltbld', 02:17:29 INFO - 'LANG': 'en_US.UTF-8', 02:17:29 INFO - 'LANGUAGE': 'en_US:en', 02:17:29 INFO - 'LOGNAME': 'cltbld', 02:17:29 INFO - 'MAIL': '/var/mail/cltbld', 02:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:29 INFO - 'MOZ_NO_REMOTE': '1', 02:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:29 INFO - 'NO_EM_RESTART': '1', 02:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:29 INFO - 'PWD': '/builds/slave/test', 02:17:29 INFO - 'SHELL': '/bin/bash', 02:17:29 INFO - 'SHLVL': '1', 02:17:29 INFO - 'TERM': 'linux', 02:17:29 INFO - 'TMOUT': '86400', 02:17:29 INFO - 'USER': 'cltbld', 02:17:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:29 INFO - '_': '/tools/buildbot/bin/python'} 02:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:17:29 INFO - Running setup.py (path:/tmp/pip-OKcYQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:17:30 INFO - Running setup.py (path:/tmp/pip-yeZndE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:17:30 INFO - Running setup.py (path:/tmp/pip-LK3Dtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:17:30 INFO - Running setup.py (path:/tmp/pip-eMjy7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:17:30 INFO - Running setup.py (path:/tmp/pip-wezu2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:17:30 INFO - Running setup.py (path:/tmp/pip-kO2TTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:17:30 INFO - Running setup.py (path:/tmp/pip-LaCKuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:17:30 INFO - Running setup.py (path:/tmp/pip-PZvXwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:17:30 INFO - Running setup.py (path:/tmp/pip-DKvYJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:17:30 INFO - Running setup.py (path:/tmp/pip-FC7vai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:17:30 INFO - Running setup.py (path:/tmp/pip-DHGBut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:17:30 INFO - Running setup.py (path:/tmp/pip-l4Lvzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:17:30 INFO - Running setup.py (path:/tmp/pip-x6SUWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:17:30 INFO - Running setup.py (path:/tmp/pip-yccgMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:17:30 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)) 02:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:30 INFO - Running setup.py (path:/tmp/pip-qDiean-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:31 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)) 02:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:17:31 INFO - Running setup.py (path:/tmp/pip-WSDlu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:17:31 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)) 02:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:17:31 INFO - Running setup.py (path:/tmp/pip-WjbYro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:17:31 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)) 02:17:31 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)) 02:17:31 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)) 02:17:31 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)) 02:17:31 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)) 02:17:31 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)) 02:17:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:17:31 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 02:17:31 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 02:17:31 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 02:17:31 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 02:17:31 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 02:17:31 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 02:17:33 INFO - Downloading blessings-1.6.tar.gz 02:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:17:33 INFO - Installing collected packages: blessings 02:17:33 INFO - Running setup.py install for blessings 02:17:33 INFO - Successfully installed blessings 02:17:33 INFO - Cleaning up... 02:17:33 INFO - Return code: 0 02:17:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:17:33 INFO - Reading from file tmpfile_stdout 02:17:33 INFO - Current package versions: 02:17:33 INFO - argparse == 1.2.1 02:17:33 INFO - blessings == 1.6 02:17:33 INFO - blobuploader == 1.2.4 02:17:33 INFO - docopt == 0.6.1 02:17:33 INFO - manifestparser == 1.1 02:17:33 INFO - mozInstall == 1.12 02:17:33 INFO - mozcrash == 0.17 02:17:33 INFO - mozdebug == 0.1 02:17:33 INFO - mozdevice == 0.48 02:17:33 INFO - mozfile == 1.2 02:17:33 INFO - mozhttpd == 0.7 02:17:33 INFO - mozinfo == 0.9 02:17:33 INFO - mozleak == 0.1 02:17:33 INFO - mozlog == 3.2 02:17:33 INFO - moznetwork == 0.27 02:17:33 INFO - mozprocess == 0.22 02:17:33 INFO - mozprofile == 0.28 02:17:33 INFO - mozrunner == 6.11 02:17:33 INFO - mozscreenshot == 0.1 02:17:33 INFO - mozsystemmonitor == 0.3 02:17:33 INFO - moztest == 0.7 02:17:33 INFO - mozversion == 1.4 02:17:33 INFO - psutil == 3.1.1 02:17:33 INFO - requests == 1.2.3 02:17:33 INFO - wsgiref == 0.1.2 02:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:33 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:33 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 02:17:33 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 02:17:33 INFO - Using env: {'DISPLAY': ':0', 02:17:33 INFO - 'HOME': '/home/cltbld', 02:17:33 INFO - 'LANG': 'en_US.UTF-8', 02:17:33 INFO - 'LANGUAGE': 'en_US:en', 02:17:33 INFO - 'LOGNAME': 'cltbld', 02:17:33 INFO - 'MAIL': '/var/mail/cltbld', 02:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:33 INFO - 'MOZ_NO_REMOTE': '1', 02:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:33 INFO - 'NO_EM_RESTART': '1', 02:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:33 INFO - 'PWD': '/builds/slave/test', 02:17:33 INFO - 'SHELL': '/bin/bash', 02:17:33 INFO - 'SHLVL': '1', 02:17:33 INFO - 'TERM': 'linux', 02:17:33 INFO - 'TMOUT': '86400', 02:17:33 INFO - 'USER': 'cltbld', 02:17:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:33 INFO - '_': '/tools/buildbot/bin/python'} 02:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 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)) 02:17:33 INFO - Cleaning up... 02:17:33 INFO - Return code: 0 02:17:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:17:33 INFO - Using env: {'DISPLAY': ':0', 02:17:33 INFO - 'HOME': '/home/cltbld', 02:17:33 INFO - 'LANG': 'en_US.UTF-8', 02:17:33 INFO - 'LANGUAGE': 'en_US:en', 02:17:33 INFO - 'LOGNAME': 'cltbld', 02:17:33 INFO - 'MAIL': '/var/mail/cltbld', 02:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:33 INFO - 'MOZ_NO_REMOTE': '1', 02:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:33 INFO - 'NO_EM_RESTART': '1', 02:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:33 INFO - 'PWD': '/builds/slave/test', 02:17:33 INFO - 'SHELL': '/bin/bash', 02:17:33 INFO - 'SHLVL': '1', 02:17:33 INFO - 'TERM': 'linux', 02:17:33 INFO - 'TMOUT': '86400', 02:17:33 INFO - 'USER': 'cltbld', 02:17:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:33 INFO - '_': '/tools/buildbot/bin/python'} 02:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:33 INFO - Downloading/unpacking jsonschema 02:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:17:35 INFO - Downloading/unpacking functools32 (from jsonschema) 02:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:17:36 INFO - warning: no files found matching '*.txt' 02:17:36 INFO - no previously-included directories found matching 'build' 02:17:36 INFO - no previously-included directories found matching 'dist' 02:17:36 INFO - no previously-included directories found matching '.git*' 02:17:36 INFO - Installing collected packages: jsonschema, functools32 02:17:36 INFO - Running setup.py install for functools32 02:17:36 INFO - warning: no files found matching '*.txt' 02:17:36 INFO - no previously-included directories found matching 'build' 02:17:36 INFO - no previously-included directories found matching 'dist' 02:17:36 INFO - no previously-included directories found matching '.git*' 02:17:36 INFO - Successfully installed jsonschema functools32 02:17:36 INFO - Cleaning up... 02:17:36 INFO - Return code: 0 02:17:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:17:36 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')]} 02:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:36 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')]} 02:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:36 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 0x7fceeb7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1908770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', '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 02:17:36 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 02:17:36 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 02:17:36 INFO - Using env: {'DISPLAY': ':0', 02:17:36 INFO - 'HOME': '/home/cltbld', 02:17:36 INFO - 'LANG': 'en_US.UTF-8', 02:17:36 INFO - 'LANGUAGE': 'en_US:en', 02:17:36 INFO - 'LOGNAME': 'cltbld', 02:17:36 INFO - 'MAIL': '/var/mail/cltbld', 02:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:36 INFO - 'MOZ_NO_REMOTE': '1', 02:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:36 INFO - 'NO_EM_RESTART': '1', 02:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:36 INFO - 'PWD': '/builds/slave/test', 02:17:36 INFO - 'SHELL': '/bin/bash', 02:17:36 INFO - 'SHLVL': '1', 02:17:36 INFO - 'TERM': 'linux', 02:17:36 INFO - 'TMOUT': '86400', 02:17:36 INFO - 'USER': 'cltbld', 02:17:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:36 INFO - '_': '/tools/buildbot/bin/python'} 02:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:36 INFO - Downloading/unpacking flake8 02:17:36 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 02:17:36 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 02:17:36 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 02:17:36 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 02:17:36 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 02:17:36 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 02:17:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:17:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:17:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:17:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:17:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:17:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:17:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:17:39 INFO - no previously-included directories found matching 'docs/_build' 02:17:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:17:39 INFO - Running setup.py install for pep8 02:17:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:17:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:17:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:17:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:17:39 INFO - no previously-included directories found matching 'docs/_build' 02:17:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:17:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:17:39 INFO - Cleaning up... 02:17:39 INFO - Return code: 0 02:17:39 INFO - Running post-action listener: _resource_record_post_action 02:17:39 INFO - Running post-action listener: _start_resource_monitoring 02:17:39 INFO - Starting resource monitoring. 02:17:39 INFO - ##### 02:17:39 INFO - ##### Finished create-virtualenv step (success) 02:17:39 INFO - ##### 02:17:39 INFO - ##### 02:17:39 INFO - ##### Running install step. 02:17:39 INFO - ##### 02:17:39 INFO - Running pre-action listener: _resource_record_pre_action 02:17:39 INFO - Running main action method: install 02:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:17:39 INFO - Reading from file tmpfile_stdout 02:17:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:17:39 INFO - Reading from file tmpfile_stdout 02:17:39 INFO - Output received: 02:17:39 INFO - Usage: mozinstall [options] installer 02:17:39 INFO - Options: 02:17:39 INFO - -h, --help show this help message and exit 02:17:39 INFO - -d DEST, --destination=DEST 02:17:39 INFO - Directory to install application into. [default: 02:17:39 INFO - "/builds/slave/test"] 02:17:39 INFO - --app=APP Application being installed. [default: firefox] 02:17:39 INFO - mkdir: /builds/slave/test/build/application 02:17:39 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'] 02:17:39 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 02:17:56 INFO - Reading from file tmpfile_stdout 02:17:56 INFO - Output received: 02:17:56 INFO - /builds/slave/test/build/application/firefox/firefox 02:17:56 INFO - Running post-action listener: _resource_record_post_action 02:17:56 INFO - ##### 02:17:56 INFO - ##### Finished install step (success) 02:17:56 INFO - ##### 02:17:56 INFO - ##### 02:17:56 INFO - ##### Running run-tests step. 02:17:56 INFO - ##### 02:17:56 INFO - Running pre-action listener: _resource_record_pre_action 02:17:56 INFO - Running main action method: run_tests 02:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:17:56 INFO - Python 2.7.3 02:17:56 INFO - Return code: 0 02:17:56 INFO - grabbing minidump binary from tooltool 02:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:56 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 0x19979c0>, '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 0x19988c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1998d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:17:56 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 02:17:56 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 02:17:56 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 02:17:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:17:56 INFO - Return code: 0 02:17:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:17:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:17:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:17:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:17:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:17:57 INFO - Return code: 0 02:17:57 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/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 02:17:57 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/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 02:17:57 INFO - Using env: {'DISPLAY': ':0', 02:17:57 INFO - 'HOME': '/home/cltbld', 02:17:57 INFO - 'LANG': 'en_US.UTF-8', 02:17:57 INFO - 'LANGUAGE': 'en_US:en', 02:17:57 INFO - 'LOGNAME': 'cltbld', 02:17:57 INFO - 'MAIL': '/var/mail/cltbld', 02:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:57 INFO - 'MOZ_NO_REMOTE': '1', 02:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:57 INFO - 'NO_EM_RESTART': '1', 02:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:57 INFO - 'PWD': '/builds/slave/test', 02:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:17:57 INFO - 'SHELL': '/bin/bash', 02:17:57 INFO - 'SHLVL': '1', 02:17:57 INFO - 'TERM': 'linux', 02:17:57 INFO - 'TMOUT': '86400', 02:17:57 INFO - 'USER': 'cltbld', 02:17:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026', 02:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:57 INFO - '_': '/tools/buildbot/bin/python'} 02:17:57 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/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 02:17:57 INFO - mozversion application_buildid: 20160523233014 02:17:57 INFO - mozversion application_changeset: a35738e12eb382c6181c530b00b814d72c7a1b7b 02:17:57 INFO - mozversion application_display_name: Nightly 02:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:17:57 INFO - mozversion application_name: Firefox 02:17:57 INFO - mozversion application_remotingname: firefox 02:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:17:57 INFO - mozversion application_vendor: Mozilla 02:17:57 INFO - mozversion application_version: 49.0a1 02:17:57 INFO - mozversion platform_buildid: 20160523233014 02:17:57 INFO - mozversion platform_changeset: a35738e12eb382c6181c530b00b814d72c7a1b7b 02:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:17:57 INFO - mozversion platform_version: 49.0a1 02:17:57 INFO - using testdate: 1464081477 02:17:57 INFO - actual date: 1464081477 02:17:57 INFO - starting webserver on 'localhost:44302' 02:17:57 INFO - SUITE-START | Running 2 tests 02:17:57 INFO - TEST-START | dromaeo_css 02:17:57 INFO - operating with platform_type : linux_ 02:17:57 INFO - Initialising browser for dromaeo_css test... 02:17:57 INFO - TEST-INFO | started process 13115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgc4meS/profile http://localhost:44302/getInfo.html) 02:18:01 INFO - PROCESS | 13115 | __metrics Screen width/height:1600/1200 02:18:01 INFO - PROCESS | 13115 | colorDepth:24 02:18:01 INFO - PROCESS | 13115 | Browser inner width/height: 1024/697 02:18:01 INFO - PROCESS | 13115 | __metrics 02:18:02 ERROR - PROCESS | 13115 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:18:03 INFO - TEST-INFO | 13115: exit 0 02:18:03 INFO - Browser initialized. 02:18:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:03 INFO - TEST-INFO | started process 13199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgc4meS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:14 INFO - PROCESS | 13199 | RSS: Main: 153223168 02:18:14 INFO - PROCESS | 13199 | 02:19:06 INFO - PROCESS | 13199 | 1464081546010 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] 02:21:13 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44302/tests/dromaeo/cssquery-ext.html) 02:21:14 INFO - PROCESS | 13199 | RSS: Main: 261132288 02:21:14 INFO - PROCESS | 13199 | 02:24:17 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-ext.html (next: http://localhost:44302/tests/dromaeo/cssquery-jquery.html) 02:24:17 INFO - PROCESS | 13199 | RSS: Main: 231682048 02:24:17 INFO - PROCESS | 13199 | 02:27:19 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44302/tests/dromaeo/cssquery-mootools.html) 02:27:20 INFO - PROCESS | 13199 | RSS: Main: 234012672 02:27:20 INFO - PROCESS | 13199 | 02:30:22 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44302/tests/dromaeo/cssquery-prototype.html) 02:30:23 INFO - PROCESS | 13199 | RSS: Main: 236335104 02:30:23 INFO - PROCESS | 13199 | 02:33:25 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44302/tests/dromaeo/cssquery-yui.html) 02:33:26 INFO - PROCESS | 13199 | RSS: Main: 219648000 02:33:26 INFO - PROCESS | 13199 | 02:36:28 INFO - PROCESS | 13199 | Cycle 1(1): loaded http://localhost:44302/tests/dromaeo/cssquery-yui.html (next: http://localhost:44302/tests/dromaeo/cssquery-dojo.html) 02:36:29 INFO - PROCESS | 13199 | RSS: Main: 267542528 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | __start_tp_report 02:36:29 INFO - PROCESS | 13199 | _x_x_mozilla_page_load 02:36:29 INFO - PROCESS | 13199 | _x_x_mozilla_page_load_details 02:36:29 INFO - PROCESS | 13199 | |i|pagename|runs| 02:36:29 INFO - PROCESS | 13199 | |0;dojo.html;3108.114187456575;3110.5178697301926;3132.107349405419;3153.2274592724784;3169.033444799337;5246.947530524693;5264.473552644734;5414.675119492833;5484.396716361202;5506.972465137674;5436.592255580827;5437.755301011454;5443.618946673734;5446.2647542581735;5542.61201715879;4892.217245240762;4926.679765815211;4982.476839931809;4992.950070499285;5116.309298244745;5028.924566131493;5039.19372900336;5064;5087.211482220262;5095.261187127864;4794.904101917959;4854.781534830923;4867.805287788484;4868.075065737534;4932.0629080474955;4869.707817530924;4884.4871288514905;4952.380952380952;4983.750812459399;5015.673981191211;4720.457147428021;4931.90136197274;4932.186189278765;4951.43058548268;4968.90062198754;5234.42421333653;5255.054090263751;5310.150375939831;5345.224942383333;5364.91952620711;5757.856053598652;5767.077267637158;5797.275340582427;5799.507041901444;5801.53587712982;5580.748866301026;5710.942890571083;5735.053716136832;5777.537796976232;5830.154627578977;5414.83755487336;5417.756200970965;5419.674819510842;5430.619856610039;5439;5941.346451890375;5944.078667806497;5957.165996760457;5961.076033214858;5961.821145365646;5409.080456322435;5656.4060773619;5699.971500142473;5706.229658995982;5706.514946229617;5817.650940943557;5869.794557190563;5870.26621672291;5873.20711703923;5885.588008839341;5768.538516918637;5781.566382521328;5792.9420705793245;5799.768009279666;5817.243758311477;5526.917096243559;5709.942900571024;5747.885042299131;5763.711814409263;5802.680852553066;4407.471103467605;4408.911821763547;4409.0520538084465;4420.115976804652;4453.799579018952;3766.8304926278383;3934.7245692801803;3938.6849052075763;3958.5051868516434;3963.3460479021214;5429.972850135803;5491.890162196733;5492.5605951523785;5497.120460726344;5504.4770746778995;5755.597108202385;5771.0477771168125;5791.391903850119;5819.592628515963;5880.14737863016;5227.424983251915;5339.0389729849;5346.4386239445075;5355.223492593552;5360.3299587551555;4907.975460122677;4929.679570827885;4932.67937584063;4940.283658869444;4965.925511117336;5857.4435428634215;5866.853328666817;5868.765249389977;5873.9412605873395;5897.240827204832;5608.10270356741;5682.176084467812;5697.202391665253;5737.368889422244;5785;5846.152307915413;5872;5895;5898.439648233411;5911.083782013795;5626.2967129108865;5628.549716022627;5630.577706671934;5639.3232812062815;5643;5579.358373786904;5666.9716651416475;5670.914936275876;5677.51741102011;5724.542036637143;5599.272094627672;5603.607747457639;5607.383187849415;5613.887722245614;5616.606837521498;5541.889162216652;5590.133529302964;5597.04850175463;5599.860003499782;5605.159226116115;5332.173513105475;5502.972485137709;5564.666120032811;5585.581081418829;5619.044762390322;5700.201971723879;5723.313202415737;5740.39725828782;5772.913406298825;5774.364819869895;5354.250404943389;5595.63628364155;5597.608167428241;5607.383187849415;5637.802676906289 02:36:29 INFO - PROCESS | 13199 | |1;ext.html;598.5570677698504;634.2547506679651;647.4658406814376;655.4723447624662;661.4410822854692;42025.369619455734;43253.35119973203;43255.13489730207;43301;46339.768301158445;44489.77755111228;45139.77430112845;45152.322715159215;45272.32091518622;45439.77280113603;8533.914660853405;8660.566971651424;8666.046734859161;8675.95662021689;8685.261752751023;8698.304135669132;8766.736997890042;8798.648054077828;8810.735677929672;8819.51492667903;8818.691345802898;8879.733607991771;8888.911110888874;8890.822183556325;8893.68872089477;8774.956125219365;8802;8814.823703525894;8823.558822058903;8824.514651694155;8786.253168480624;8871.334649901282;8875.289976801905;8885.555722213863;8889.377743557954;39059.80470097631;39158;39393.212135757414;39396.80301598473;39480;3533.823308834548;3569.910752231215;3596.730245231618;3602.7297952653657;4049.5343035550995;31191.376172476652;31383.843080784678;31411.528827067614;31471.37057258842;32890.342193156;4411.205982923073;4459.888502787424;4471.843485478025;4537.769293700592;4611.054733779567;327889;328334;329667;331979;332658;51945.220821687704;57370.713146434;58408.4159158403;58617.706911466026;60442;63996.36003639997;64092.679536602016;64206.6789666058;64369;64479;16800.91599542019;16969.745453818203;16972.32110715582;16979.575510612085;16986.830131698523;10054.597816087275;12855.614331570068;12971.740565188833;13069.803952940714;13425.731485370237;18372.632547348978;18373.26506939734;18385.724214136797;18438.631227375376;18513.90743046303;6869.450443964471;7081.398081163055;7153.535020223669;7182;7199.640017999079;928.1965826846044;1067.8985496377832;1135.2564070533813;1136.091127098318;1187.8633957095044;31869.521957170662;32995.505067424005;33080;35576.466353004726;35703.28593428169;1112.449337577904;1118.2731224703846;1136.4431428599926;1153.4348169396935;1168.9649310520697;15998.9200053999;16370.590735231715;16391.590210244838;16480.505584832474;16566.337346506247;469741;471271;473066;475834;476516;54451;55908.44091559033;55913.44086559083;56088.71955640196;56106.71946640241;1237.8205160251714;1368.493657346788;1387.7293927684207;1397.4899161805868;1416.122004357305;30624;32179;32479;32535.674643254213;32925;47714.28428573505;48395.758021209665;48421.75789121032;48578.271325930844;48614.513854861;409710;413480;413538;413766;414334;24051.639225411283;26428.867855661367;27102.238354506895;27333.180004599893;28221.294467638472;44905;45714;45840;45970.7701461504;46774.298385524926;35018.299634007686;35098.649013510556;35454;36106.8194659025;36354;38526.036849079;38678;38886.6111338883;38904.80547597244;39187.6081239184;38063.637316196044;38557.807210963765;38940.61059389483;39154.6084539151;39330.803345983084;33796.831015844764;35012.64987350094;35401.468977965866;35611;35832.46251306285;26667.599985999837;26998.865005674845;27031.862157192034;27106.186814395598;27212.31969200786 02:36:29 INFO - PROCESS | 13199 | |2;jquery.html;384.31016325695373;387.8041588997556;388.6598141535306;399.47668554194007;412.9979350103249;14238.28808559573;15841.207939603002;17725.911370443147;19223.519412014688;19228.519287017814;17866.28534858604;18654.906725466353;18689.158987845545;18766.43700688978;19055.237790488398;4958.603311735062;5139.640225184238;5683.147527870811;5824.330202026778;5833.8833223335505;3919.098607320318;5664.518515926131;5684.573656975723;5743.368229494752;5978.581499295029;6006.159137720722;6006.489448396892;6016.458518733313;6023.247094113236;6026.0960855871535;5815.127730840365;5959.10613407988;5977.372375900533;6014.96992515039;6021.90967135489;5629.324481062299;5730.169125476824;5747.109198074305;5750.453706897838;5753.338366087912;21892.781072189235;22341.664875026887;22722.318330450114;22737.545249095092;22777.886110569507;2246.7191601049867;2252;2325.8837058147024;2418.4921166555046;2792.567152091409;13769.862301376957;14276.214808185545;14292.928535357256;14398.640033999129;14886.553403397915;1870.9064546772743;1895.1945423195086;1903.038965322517;1929.8359639430664;1962.7644682638174;77048.61475692641;78936;79981;80977.19022809755;82455.9999999994;10930.289531180448;10950.835737463944;10954.123670106372;11127.554897803997;11155.888441115647;13713.245771482465;15739.842601574066;15781.368745250062;15806.288717007763;31603.367932641217;9727.173190278763;9995.100440960348;10023.448710320856;10144.949275253577;10307.536160872778;8358.623861926228;8386.329093672492;8423.915760842436;8461.830763384698;8769.868451973225;8661.696840610675;8729.65081396737;9011.369204155646;9087.36388452802;9205.309601779893;3232.8383580821337;3237.8219197943868;3298.5321531918544;3340.5824271966003;3410.0963244740165;883.885094937654;910.2444970674325;947.1712251779693;975.2100798353215;979.2410881566842;17505.38731144404;18155.27378904829;18192.818071819376;18280.725789113174;18596.512279017916;926.2682480840195;929.400536653868;938.5401153434768;942.2320808541017;963.1184051630323;10160.4919754012;10829.99166236555;11778.646640600795;11837.704057398461;11847.703807404712;177776;178288.10855945636;466610;477703;478583;88701;96414;96796;97718;100759.49620251852;1000.6797824696173;1024.3904876598413;1031.747221930632;1039.4594810698395;1051.4427353502808;17202.397916072878;17224.588862198336;17277.049762263196;17382.5654358637;17448.73826892572;28138.281253873924;38549;39230.607693923834;39439;42403;57573.712131439075;58284.70857645685;59675;60280;60447;8475.364347673825;8573.271271941954;8690.695825646071;8757;9103.226225770619;11989.820152697543;12716.427760750974;12944.741105178033;13215.933920330337;13498.59504214875;6122.112293717475;11270.154738394489;11504;11513.366764828015;11746.236494627821;11201.831972520256;11230.887691122984;11333.376664283544;11463.656090317303;11569.595064172714;11516.366599837089;11682.24065435744;11718.414079296172;11738.471768770254;11970.521179152736;8673.522956237468;8777.692780752643;8959.41763785352;9103.954480227556;9154;7870.252326029018;8061.113277539584;8063.959680201561;8087.595620218848;8325.708600198965 02:36:29 INFO - PROCESS | 13199 | |3;mootools.html;1325.6354502511815;1461.9926900365497;1487.6727120033593;1633.5344426838353;1801.7297405389197;7837.686492540299;8189;8203.958980205105;8387.287080598142;8395.748127556168;8199.057108432517;8347.290480309166;8362.08017118118;8370.204830541104;8370.246677798998;2000.0999550202466;2239;2300.723913130427;2331.6036273833406;2336.9766302337016;2348.9295321140307;2356.2931120663816;2364.869932153731;2365.47959448921;2369.893354799038;2245.236619549353;2292.988535057322;2300.056976639578;2302.792748652621;2307.215546714117;1989.2242025610024;2224.3549370682404;2280.258915852338;2281.167373908528;2295.357299956015;2174.1629472652985;2183.3231698173618;2192.78072192781;2194.2758889566403;2203.768604296558;8251.917480825176;8288.171182881664;8302.377321700897;8323.209295117014;8327.417080804345;4910.165271903785;5036.6726162799305;5041.521055499722;5051.116054690451;5051.368578927634;3167.5407065975537;3216.372807302577;3242.1084201844446;3253.235489659928;3257.088015355704;1056.730533713898;1060.3796778884362;1066.344198318029;1079.5357996061691;1080.6109800471825;11615.6515304541;11625.767484650345;11643.476043577975;11648.184627076109;11663.241889277255;4410.272305069691;4434.157510073076;4503.301988191835;4508.909821803545;4624.398828152319;9778.364406313567;9778.75553111178;9787.021297870298;9793.657221997339;9811.901880981242;4567.566081222279;5198.636095473281;5201.505856943584;5214.191800270964;5220.477952204825;4634.050019745944;4714.905701886011;4764.785584648699;4808.639352048541;4816.325714399987;3699.2416554606243;3823.0824602095295;3823.1589050408866;3856.8842934712;3898.863539776151;1223.614561413152;1236.5733821831454;1238.9442475088642;1247.6631309546372;1255.1026016398318;786.5791801386231;884.1467983395925;894.8478758611052;911.48956584313;916.6699988004314;5291.867703307448;5323.121684922022;5395.109806881899;5448;5592.720363981784;414.345334371692;428.42804855518233;435.40567125872957;437.78767297860514;445.888527868033;3605.94591081134;3662.066173125836;3724.3296206682517;3732.794696291676;3753.0992561784974;9837.950810246046;10097.848532272023;10314.690559283234;10320.48397580133;10341.327813692085;10174.440405777605;10247;10257;10279.280450368551;10306.433146176882;7788.337991270692;7797.493162944391;7864.646090925922;7939.285464308125;7951.324137448266;5346.759395827119;5349.1976203569775;5437.90175894215;5500.367457742411;5512.614117011931;9463.905360946303;9518.333716640045;9560.76098097553;9566.330356874952;9592.08875156859;9099;9538.85691714611;9546.761330966503;9803.607855685692;9856.31005829585;6775.525713200029;7239.963800180965;7408.111026676834;7542.47202695806;7708.421868359784;7780.2219778021745;7789.493682910593;7854.586174488647;7855.33229675484;7858.13560508355;6817.420519255918;6899.6205208714;7054.329838665319;7153.4992550520965;7205.855882882418;6660.134182556237;6673.666316684244;6741.494387920828;6833.487488438288;7009.859802803813;6281.403266689657;6291.465225455888;6295.5907865988565;6396.712147953446;6437.25971513282;4657.930131048105;4671.696339737906;4675.509071547439;4707.552782485658;4769.046190761792;4467.553244675636;4531.504603480909;4541.591256786905;4638.026014536985;4639.652026097989 02:36:29 INFO - PROCESS | 13199 | |4;prototype.html;303.4522686550775;319.7633751024242;324.2024619436187;325.9625143108543;326.9934601307973;4921.901561968759;5082.923756143661;5322.308099947007;5323.9733801330985;5324.600654950879;5242.895142097156;5283.6037297202765;5284.682919024861;5284.894302113956;5296.3379577552805;4113.9794301028605;4134.7725875076785;4155.189738001091;4161.625453709165;4189.266878296301;3960.267350540145;4054.736442131267;4134.607212314841;4154.335306350985;4164.83340666373;4093.9385909211387;4094.34490481523;4096.467459230296;4096.918061638766;4100.1594673092095;4146;4146.979265103685;4155.91688166235;4175.5615660355525;4179.707420480568;3423.880164194266;3666.651668091527;3705.7776533407814;3718.888433347004;3721.4789929409903;5064.139096353629;5093.286939828427;5105.340764251633;5127.9743601282125;5141.948580514184;4617.252734622894;4630.356223540662;4631.305304204397;4636.976815115937;4646.930296045562;5308.416074231832;5461.69960652164;5501.872116216206;5503.7798488060425;5528.115501519777;3922.7447216890605;3925.450436938831;3930.1746633207063;3932.2528719543197;3933.606639336072;5484.369297530795;5548.722563871831;5694.601377903548;5712.514746165985;5791.247137872049;3892.5328960524353;3899.4735710678697;3915.9804200979383;3932.724709270381;3933.6853051755793;3960.5247370315747;3982.203559288154;3983.4423180754716;3993.121513267077;3996.680265578747;4580.244259697112;4599.033044312135;4603.516630753789;4605.930911036337;4618.237990731559;5250.448702886219;5517.5585953123655;5534.889302214014;5567.608097975506;5574;1390.2978995607155;1401.5515035188641;1406.7186562687502;1407.985920140806;1414.2009764483034;848.5841937450605;896.3591032411857;899.9910000899907;913.8355096082769;917.3395155488038;4678.017616300547;4807.4471435784635;4814.5907597854575;4855.393075865446;4858.295547145644;5001.249812528077;5028.748562571856;5052.974735126374;5070.7464626768515;5088.465711100281;4779.832705855279;4785.49752276013;4815.3258543803895;4833.951660483421;4997.750112494434;3013.3973205359016;3018.5623084652602;3026.0014195315935;3027.3339865229614;3046.482098043338;5871.941280587225;5874.50066744323;5880;5919.200907877467;5929.738643745923;5556.527695145958;5762.88474230513;5770.9414010574465;5794.30468343793;5802.854928626733;5791.5656325775735;5828.504577110908;5842.883142337129;5884.58807883444;5913.497352725067;5416.51251387377;5648.237487939075;5689.914651280317;5813.738381772915;5817.447342502455;5628.60599758013;5690.601657883908;5704.743286552198;5712.5429965601825;5715.399883012224;5614.129809879475;5705.686187259741;5857.209276747584;5874.353821079592;5879.412058794086;3960.9107495438984;3964.266610677034;3977.8607748728655;3997.5402828675074;3998.9805148399873;5704.401037890962;5705.657660540381;5735.627184233012;5755.8561035974435;5769.8557536061935;5336.439673834191;5510.256115424367;5536.252605898313;5557.388687244319;5568.860778480408;5460;5510.448955104457;5557.41647127062;5559.555235581225;5574.163875418558;5271.894562108813;5469.632591852037;5481.890362192654;5497.972510137583;5501.174823776466;5564.582656300713;5623.971880140573;5627.971860140673;5647.830565083054;5658.726786473011;5512.6968016759465;5532.1425179097305;5540.196671482693;5542.861428464159;5544.833654990357 02:36:29 INFO - PROCESS | 13199 | |5;yui.html;840.7808677417744;851.9233269005788;861.5692153923038;863.7063398444532;890.2788741119693;13438.731225375499;13594.592162235123;13607.523736669205;13616.183029018266;13628.659283517916;12263.141580089397;12601.054920880948;12701.428435720392;12726.554570590031;12756;819.1071731812324;819.8934138561979;823.567626995826;825.1253671108614;826.9917300827005;680.7855525509449;790.6244533846406;809.995950020252;813.5810057820198;817.0767033252446;852.6845067325098;860.4536119564091;862.2670729879615;862.3144600042981;862.4221771413169;858.51064893011;858.8196478739472;858.9742307730778;859.4585411190973;859.9355048371397;519.8674338043775;605.9575829691923;624.4192900602438;624.815679374581;626.3767551286454;13553.59339219815;13566.932165339209;13579.321033948263;13595.184288942695;13628.523001694992;13153.53962611304;13347.399367028507;13538.526151584647;13577.59267221985;13652.180869147884;12544.498220071186;12574.68563285916;12599;12715.30065846378;12808;4360.825566977317;4375.890602734925;4396.120775844812;4429.889252768674;4475.888102797424;59516.40483595152;59848.40151598472;59879.401205987815;60109.6994515029;62163.689181554255;10533.315334503233;10737.409442480583;10866.239363244655;10988.890111098946;11041.39272340029;19400.2239910402;19477.12352944121;19507.707384389247;19510.804891951182;19693;8164.673413063411;8188.303994160563;8322.916770832335;8409.41134120618;8564.357673174536;4632.374629425052;4659.6505262105475;4686.81252749893;4725.669203155746;4859.829905953275;3284.261041265696;3358.596968363763;3361.6302206757236;3378.054144839449;3384.9323013540084;571.6770024935898;577.3995045152993;581.3575998521573;583.7577405376805;585.7569108819793;696.9372756451944;700.831800367908;707.0525495835604;712.1383126417094;724.3770357492552;8643.438176518506;8713.651453941771;8913.866292005625;8942.821143577092;9519.095685909828;673;700.4011570107587;702.1328659106;708.1749761527865;713.9178994415605;4234.216669916075;4249.213895429355;4259.297215959394;4279.33670281107;4324.870253892388;68482;69040;69252.653736731;69339;69345;59645.701771490865;60483.69758151269;61021.69489152526;61069.38930610637;62161.37838621556;56166.438335616935;56340.43659563434;56420.153697694564;56421.71789141028;56813.147802782994;7946.8807967881685;8006.639701213576;8060.073091594541;8164;8223.835523289381;38092.80953595214;38119.237615248094;38143.42784858174;38282.42576361413;38513.91888648958;47550.76224618855;50670.74664626653;50867.23699144442;51305.7434712824;53039.20441193308;10379.584816607252;10486.37081775096;10552.366857988545;10722.517486713272;10786.784264314827;11699.707507312045;11758.70603234926;11961.162718609614;12331.198472099644;12417.379131043592;9043.728688139103;10674.758300756928;10793.514291856729;11061.889381106086;12503.187292825936;12698.936505317415;13366.131201471873;13424.261665608095;13551.390187441786;13915.791263131263;11747.530098796295;11809.704757381134;12031.4585843639;12060;12499.250044997329;9533.90466095358;9642.903570964201;10017.599296028076;10084.94957525237;10257.28199026061;9882.851757223503;10287.82788151901;10432.426216558162;10446.582136714751;10461.163106951273 02:36:29 INFO - PROCESS | 13199 | __end_tp_report 02:36:29 INFO - PROCESS | 13199 | __start_cc_report 02:36:29 INFO - PROCESS | 13199 | _x_x_mozilla_cycle_collect,902 02:36:29 INFO - PROCESS | 13199 | __end_cc_report 02:36:29 INFO - PROCESS | 13199 | __startTimestamp1464082589101__endTimestamp 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | ------- Summary: start ------- 02:36:29 INFO - PROCESS | 13199 | Number of tests: 6 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#0] dojo.html Cycles:165 Average:5350.78 Median:5579.36 stddev:598.87 (10.7%) stddev-sans-first:574.29 02:36:29 INFO - PROCESS | 13199 | Values: 3108.1 3110.5 3132.1 3153.2 3169.0 5246.9 5264.5 5414.7 5484.4 5507.0 5436.6 5437.8 5443.6 5446.3 5542.6 4892.2 4926.7 4982.5 4993.0 5116.3 5028.9 5039.2 5064.0 5087.2 5095.3 4794.9 4854.8 4867.8 4868.1 4932.1 4869.7 4884.5 4952.4 4983.8 5015.7 4720.5 4931.9 4932.2 4951.4 4968.9 5234.4 5255.1 5310.2 5345.2 5364.9 5757.9 5767.1 5797.3 5799.5 5801.5 5580.7 5710.9 5735.1 5777.5 5830.2 5414.8 5417.8 5419.7 5430.6 5439.0 5941.3 5944.1 5957.2 5961.1 5961.8 5409.1 5656.4 5700.0 5706.2 5706.5 5817.7 5869.8 5870.3 5873.2 5885.6 5768.5 5781.6 5792.9 5799.8 5817.2 5526.9 5709.9 5747.9 5763.7 5802.7 4407.5 4408.9 4409.1 4420.1 4453.8 3766.8 3934.7 3938.7 3958.5 3963.3 5430.0 5491.9 5492.6 5497.1 5504.5 5755.6 5771.0 5791.4 5819.6 5880.1 5227.4 5339.0 5346.4 5355.2 5360.3 4908.0 4929.7 4932.7 4940.3 4965.9 5857.4 5866.9 5868.8 5873.9 5897.2 5608.1 5682.2 5697.2 5737.4 5785.0 5846.2 5872.0 5895.0 5898.4 5911.1 5626.3 5628.5 5630.6 5639.3 5643.0 5579.4 5667.0 5670.9 5677.5 5724.5 5599.3 5603.6 5607.4 5613.9 5616.6 5541.9 5590.1 5597.0 5599.9 5605.2 5332.2 5503.0 5564.7 5585.6 5619.0 5700.2 5723.3 5740.4 5772.9 5774.4 5354.3 5595.6 5597.6 5607.4 5637.8 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#1] ext.html Cycles:180 Average:56755.25 Median:39395.01 stddev:108272.32 (274.8%) stddev-sans-first:108493.96 02:36:29 INFO - PROCESS | 13199 | Values: 598.6 634.3 647.5 655.5 661.4 42025.4 43253.4 43255.1 43301.0 46339.8 44489.8 45139.8 45152.3 45272.3 45439.8 8533.9 8660.6 8666.0 8676.0 8685.3 8698.3 8766.7 8798.6 8810.7 8819.5 8818.7 8879.7 8888.9 8890.8 8893.7 8775.0 8802.0 8814.8 8823.6 8824.5 8786.3 8871.3 8875.3 8885.6 8889.4 39059.8 39158.0 39393.2 39396.8 39480.0 3533.8 3569.9 3596.7 3602.7 4049.5 31191.4 31383.8 31411.5 31471.4 32890.3 4411.2 4459.9 4471.8 4537.8 4611.1 327889.0 328334.0 329667.0 331979.0 332658.0 51945.2 57370.7 58408.4 58617.7 60442.0 63996.4 64092.7 64206.7 64369.0 64479.0 16800.9 16969.7 16972.3 16979.6 16986.8 10054.6 12855.6 12971.7 13069.8 13425.7 18372.6 18373.3 18385.7 18438.6 18513.9 6869.5 7081.4 7153.5 7182.0 7199.6 928.2 1067.9 1135.3 1136.1 1187.9 31869.5 32995.5 33080.0 35576.5 35703.3 1112.4 1118.3 1136.4 1153.4 1169.0 15998.9 16370.6 16391.6 16480.5 16566.3 469741.0 471271.0 473066.0 475834.0 476516.0 54451.0 55908.4 55913.4 56088.7 56106.7 1237.8 1368.5 1387.7 1397.5 1416.1 30624.0 32179.0 32479.0 32535.7 32925.0 47714.3 48395.8 48421.8 48578.3 48614.5 409710.0 413480.0 413538.0 413766.0 414334.0 24051.6 26428.9 27102.2 27333.2 28221.3 44905.0 45714.0 45840.0 45970.8 46774.3 35018.3 35098.6 35454.0 36106.8 36354.0 38526.0 38678.0 38886.6 38904.8 39187.6 38063.6 38557.8 38940.6 39154.6 39330.8 33796.8 35012.6 35401.5 35611.0 35832.5 26667.6 26998.9 27031.9 27106.2 27212.3 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#2] jquery.html Cycles:180 Average:25461.64 Median:1897.20 stddev:64457.81 (3397.5%) stddev-sans-first:64611.13 02:36:29 INFO - PROCESS | 13199 | Values: 384.3 387.8 388.7 399.5 413.0 14238.3 15841.2 17725.9 19223.5 19228.5 17866.3 18654.9 18689.2 18766.4 19055.2 4958.6 5139.6 5683.1 5824.3 5833.9 3919.1 5664.5 5684.6 5743.4 5978.6 6006.2 6006.5 6016.5 6023.2 6026.1 5815.1 5959.1 5977.4 6015.0 6021.9 5629.3 5730.2 5747.1 5750.5 5753.3 21892.8 22341.7 22722.3 22737.5 22777.9 2246.7 2252.0 2325.9 2418.5 2792.6 13769.9 14276.2 14292.9 14398.6 14886.6 1870.9 1895.2 1903.0 1929.8 1962.8 77048.6 78936.0 79981.0 80977.2 82456.0 10930.3 10950.8 10954.1 11127.6 11155.9 13713.2 15739.8 15781.4 15806.3 31603.4 9727.2 9995.1 10023.4 10144.9 10307.5 8358.6 8386.3 8423.9 8461.8 8769.9 8661.7 8729.7 9011.4 9087.4 9205.3 3232.8 3237.8 3298.5 3340.6 3410.1 883.9 910.2 947.2 975.2 979.2 17505.4 18155.3 18192.8 18280.7 18596.5 926.3 929.4 938.5 942.2 963.1 10160.5 10830.0 11778.6 11837.7 11847.7 177776.0 178288.1 466610.0 477703.0 478583.0 88701.0 96414.0 96796.0 97718.0 100759.5 1000.7 1024.4 1031.7 1039.5 1051.4 17202.4 17224.6 17277.0 17382.6 17448.7 28138.3 38549.0 39230.6 39439.0 42403.0 57573.7 58284.7 59675.0 60280.0 60447.0 8475.4 8573.3 8690.7 8757.0 9103.2 11989.8 12716.4 12944.7 13215.9 13498.6 6122.1 11270.2 11504.0 11513.4 11746.2 11201.8 11230.9 11333.4 11463.7 11569.6 11516.4 11682.2 11718.4 11738.5 11970.5 8673.5 8777.7 8959.4 9104.0 9154.0 7870.3 8061.1 8064.0 8087.6 8325.7 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#3] mootools.html Cycles:180 Average:5434.16 Median:4739.85 stddev:3098.95 (65.4%) stddev-sans-first:3092.27 02:36:29 INFO - PROCESS | 13199 | Values: 1325.6 1462.0 1487.7 1633.5 1801.7 7837.7 8189.0 8204.0 8387.3 8395.7 8199.1 8347.3 8362.1 8370.2 8370.2 2000.1 2239.0 2300.7 2331.6 2337.0 2348.9 2356.3 2364.9 2365.5 2369.9 2245.2 2293.0 2300.1 2302.8 2307.2 1989.2 2224.4 2280.3 2281.2 2295.4 2174.2 2183.3 2192.8 2194.3 2203.8 8251.9 8288.2 8302.4 8323.2 8327.4 4910.2 5036.7 5041.5 5051.1 5051.4 3167.5 3216.4 3242.1 3253.2 3257.1 1056.7 1060.4 1066.3 1079.5 1080.6 11615.7 11625.8 11643.5 11648.2 11663.2 4410.3 4434.2 4503.3 4508.9 4624.4 9778.4 9778.8 9787.0 9793.7 9811.9 4567.6 5198.6 5201.5 5214.2 5220.5 4634.1 4714.9 4764.8 4808.6 4816.3 3699.2 3823.1 3823.2 3856.9 3898.9 1223.6 1236.6 1238.9 1247.7 1255.1 786.6 884.1 894.8 911.5 916.7 5291.9 5323.1 5395.1 5448.0 5592.7 414.3 428.4 435.4 437.8 445.9 3605.9 3662.1 3724.3 3732.8 3753.1 9838.0 10097.8 10314.7 10320.5 10341.3 10174.4 10247.0 10257.0 10279.3 10306.4 7788.3 7797.5 7864.6 7939.3 7951.3 5346.8 5349.2 5437.9 5500.4 5512.6 9463.9 9518.3 9560.8 9566.3 9592.1 9099.0 9538.9 9546.8 9803.6 9856.3 6775.5 7240.0 7408.1 7542.5 7708.4 7780.2 7789.5 7854.6 7855.3 7858.1 6817.4 6899.6 7054.3 7153.5 7205.9 6660.1 6673.7 6741.5 6833.5 7009.9 6281.4 6291.5 6295.6 6396.7 6437.3 4657.9 4671.7 4675.5 4707.6 4769.0 4467.6 4531.5 4541.6 4638.0 4639.7 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#4] prototype.html Cycles:180 Average:4603.23 Median:5134.96 stddev:1360.74 (26.5%) stddev-sans-first:1325.73 02:36:29 INFO - PROCESS | 13199 | Values: 303.5 319.8 324.2 326.0 327.0 4921.9 5082.9 5322.3 5324.0 5324.6 5242.9 5283.6 5284.7 5284.9 5296.3 4114.0 4134.8 4155.2 4161.6 4189.3 3960.3 4054.7 4134.6 4154.3 4164.8 4093.9 4094.3 4096.5 4096.9 4100.2 4146.0 4147.0 4155.9 4175.6 4179.7 3423.9 3666.7 3705.8 3718.9 3721.5 5064.1 5093.3 5105.3 5128.0 5141.9 4617.3 4630.4 4631.3 4637.0 4646.9 5308.4 5461.7 5501.9 5503.8 5528.1 3922.7 3925.5 3930.2 3932.3 3933.6 5484.4 5548.7 5694.6 5712.5 5791.2 3892.5 3899.5 3916.0 3932.7 3933.7 3960.5 3982.2 3983.4 3993.1 3996.7 4580.2 4599.0 4603.5 4605.9 4618.2 5250.4 5517.6 5534.9 5567.6 5574.0 1390.3 1401.6 1406.7 1408.0 1414.2 848.6 896.4 900.0 913.8 917.3 4678.0 4807.4 4814.6 4855.4 4858.3 5001.2 5028.7 5053.0 5070.7 5088.5 4779.8 4785.5 4815.3 4834.0 4997.8 3013.4 3018.6 3026.0 3027.3 3046.5 5871.9 5874.5 5880.0 5919.2 5929.7 5556.5 5762.9 5770.9 5794.3 5802.9 5791.6 5828.5 5842.9 5884.6 5913.5 5416.5 5648.2 5689.9 5813.7 5817.4 5628.6 5690.6 5704.7 5712.5 5715.4 5614.1 5705.7 5857.2 5874.4 5879.4 3960.9 3964.3 3977.9 3997.5 3999.0 5704.4 5705.7 5735.6 5755.9 5769.9 5336.4 5510.3 5536.3 5557.4 5568.9 5460.0 5510.4 5557.4 5559.6 5574.2 5271.9 5469.6 5481.9 5498.0 5501.2 5564.6 5624.0 5628.0 5647.8 5658.7 5512.7 5532.1 5540.2 5542.9 5544.8 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - PROCESS | 13199 | [#5] yui.html Cycles:180 Average:15549.59 Median:26205.30 stddev:19197.75 (73.3%) stddev-sans-first:19219.83 02:36:29 INFO - PROCESS | 13199 | Values: 840.8 851.9 861.6 863.7 890.3 13438.7 13594.6 13607.5 13616.2 13628.7 12263.1 12601.1 12701.4 12726.6 12756.0 819.1 819.9 823.6 825.1 827.0 680.8 790.6 810.0 813.6 817.1 852.7 860.5 862.3 862.3 862.4 858.5 858.8 859.0 859.5 859.9 519.9 606.0 624.4 624.8 626.4 13553.6 13566.9 13579.3 13595.2 13628.5 13153.5 13347.4 13538.5 13577.6 13652.2 12544.5 12574.7 12599.0 12715.3 12808.0 4360.8 4375.9 4396.1 4429.9 4475.9 59516.4 59848.4 59879.4 60109.7 62163.7 10533.3 10737.4 10866.2 10988.9 11041.4 19400.2 19477.1 19507.7 19510.8 19693.0 8164.7 8188.3 8322.9 8409.4 8564.4 4632.4 4659.7 4686.8 4725.7 4859.8 3284.3 3358.6 3361.6 3378.1 3384.9 571.7 577.4 581.4 583.8 585.8 696.9 700.8 707.1 712.1 724.4 8643.4 8713.7 8913.9 8942.8 9519.1 673.0 700.4 702.1 708.2 713.9 4234.2 4249.2 4259.3 4279.3 4324.9 68482.0 69040.0 69252.7 69339.0 69345.0 59645.7 60483.7 61021.7 61069.4 62161.4 56166.4 56340.4 56420.2 56421.7 56813.1 7946.9 8006.6 8060.1 8164.0 8223.8 38092.8 38119.2 38143.4 38282.4 38513.9 47550.8 50670.7 50867.2 51305.7 53039.2 10379.6 10486.4 10552.4 10722.5 10786.8 11699.7 11758.7 11961.2 12331.2 12417.4 9043.7 10674.8 10793.5 11061.9 12503.2 12698.9 13366.1 13424.3 13551.4 13915.8 11747.5 11809.7 12031.5 12060.0 12499.3 9533.9 9642.9 10017.6 10084.9 10257.3 9882.9 10287.8 10432.4 10446.6 10461.2 02:36:29 INFO - PROCESS | 13199 | -------- Summary: end -------- 02:36:29 INFO - PROCESS | 13199 | 02:36:29 INFO - TEST-INFO | 13199: exit 0 02:36:29 INFO - TEST-OK | dromaeo_css | took 1112267ms 02:36:29 INFO - TEST-START | kraken 02:36:29 INFO - operating with platform_type : linux_ 02:36:29 INFO - Initialising browser for kraken test... 02:36:29 INFO - TEST-INFO | started process 13377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK_QcIQ/profile http://localhost:44302/getInfo.html) 02:36:33 INFO - PROCESS | 13377 | __metrics Screen width/height:1600/1200 02:36:33 INFO - PROCESS | 13377 | colorDepth:24 02:36:33 INFO - PROCESS | 13377 | Browser inner width/height: 1024/697 02:36:33 INFO - PROCESS | 13377 | __metrics 02:36:34 ERROR - PROCESS | 13377 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:36:35 INFO - TEST-INFO | 13377: exit 0 02:36:35 INFO - Browser initialized. 02:36:35 INFO - Running cycle 1/1 for kraken test... 02:36:35 INFO - TEST-INFO | started process 13459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK_QcIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:47 INFO - PROCESS | 13459 | RSS: Main: 153378816 02:36:47 INFO - PROCESS | 13459 | 02:36:50 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44302/tests/kraken/driver.html?testName=audio-beat-detection) 02:36:50 INFO - PROCESS | 13459 | RSS: Main: 209055744 02:36:50 INFO - PROCESS | 13459 | 02:36:53 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44302/tests/kraken/driver.html?testName=audio-dft) 02:36:54 INFO - PROCESS | 13459 | RSS: Main: 197046272 02:36:54 INFO - PROCESS | 13459 | 02:36:57 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44302/tests/kraken/driver.html?testName=audio-fft) 02:36:58 INFO - PROCESS | 13459 | RSS: Main: 265506816 02:36:58 INFO - PROCESS | 13459 | 02:37:00 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44302/tests/kraken/driver.html?testName=audio-oscillator) 02:37:00 INFO - PROCESS | 13459 | RSS: Main: 174571520 02:37:00 INFO - PROCESS | 13459 | 02:37:03 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:03 INFO - PROCESS | 13459 | RSS: Main: 178069504 02:37:03 INFO - PROCESS | 13459 | 02:37:07 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44302/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:07 INFO - PROCESS | 13459 | RSS: Main: 214491136 02:37:07 INFO - PROCESS | 13459 | 02:37:11 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44302/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:11 INFO - PROCESS | 13459 | RSS: Main: 212578304 02:37:11 INFO - PROCESS | 13459 | 02:37:14 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44302/tests/kraken/driver.html?testName=json-parse-financial) 02:37:15 INFO - PROCESS | 13459 | RSS: Main: 213721088 02:37:15 INFO - PROCESS | 13459 | 02:37:17 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:17 INFO - PROCESS | 13459 | RSS: Main: 203943936 02:37:17 INFO - PROCESS | 13459 | 02:37:19 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:37:20 INFO - PROCESS | 13459 | RSS: Main: 206356480 02:37:20 INFO - PROCESS | 13459 | 02:37:22 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:37:23 INFO - PROCESS | 13459 | RSS: Main: 216887296 02:37:23 INFO - PROCESS | 13459 | 02:37:25 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:37:26 INFO - PROCESS | 13459 | RSS: Main: 222777344 02:37:26 INFO - PROCESS | 13459 | 02:37:29 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:37:29 INFO - PROCESS | 13459 | RSS: Main: 219377664 02:37:29 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | Cycle 1(1): loaded http://localhost:44302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44302/tests/kraken/driver.html?testName=ai-astar) 02:37:31 INFO - PROCESS | 13459 | RSS: Main: 264605696 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | __start_tp_report 02:37:31 INFO - PROCESS | 13459 | _x_x_mozilla_page_load 02:37:31 INFO - PROCESS | 13459 | _x_x_mozilla_page_load_details 02:37:31 INFO - PROCESS | 13459 | |i|pagename|runs| 02:37:31 INFO - PROCESS | 13459 | |0;ai-astar;111;104;111;111;111;112;110;109;110;112 02:37:31 INFO - PROCESS | 13459 | |1;audio-beat-detection;152;126;125;200;125;125;152;125;157;133 02:37:31 INFO - PROCESS | 13459 | |2;audio-dft;160;161;160;160;161;162;162;163;168;160 02:37:31 INFO - PROCESS | 13459 | |3;audio-fft;75;76;76;140;75;76;75;76;125;75 02:37:31 INFO - PROCESS | 13459 | |4;audio-oscillator;92;92;158;93;94;94;128;91;92;131 02:37:31 INFO - PROCESS | 13459 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;116;117;117 02:37:31 INFO - PROCESS | 13459 | |6;imaging-darkroom;147;146;146;147;147;146;147;146;147;146 02:37:31 INFO - PROCESS | 13459 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 02:37:31 INFO - PROCESS | 13459 | |8;json-parse-financial;56;56;57;55;63;56;56;107;58;56 02:37:31 INFO - PROCESS | 13459 | |9;json-stringify-tinderbox;62;62;62;62;63;62;63;62;63;68 02:37:31 INFO - PROCESS | 13459 | |10;stanford-crypto-aes;80;83;82;78;79;81;79;79;79;80 02:37:31 INFO - PROCESS | 13459 | |11;stanford-crypto-ccm;131;120;132;119;118;119;128;119;197;121 02:37:31 INFO - PROCESS | 13459 | |12;stanford-crypto-pbkdf2;163;164;158;161;166;163;164;165;168;163 02:37:31 INFO - PROCESS | 13459 | |13;stanford-crypto-sha256-iterative;63;62;66;62;63;61;62;62;61;70 02:37:31 INFO - PROCESS | 13459 | __end_tp_report 02:37:31 INFO - PROCESS | 13459 | __start_cc_report 02:37:31 INFO - PROCESS | 13459 | _x_x_mozilla_cycle_collect,1887 02:37:31 INFO - PROCESS | 13459 | __end_cc_report 02:37:31 INFO - PROCESS | 13459 | __startTimestamp1464082651661__endTimestamp 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | ------- Summary: start ------- 02:37:31 INFO - PROCESS | 13459 | Number of tests: 14 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:2.45 02:37:31 INFO - PROCESS | 13459 | Values: 111.0 104.0 111.0 111.0 111.0 112.0 110.0 109.0 110.0 112.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.50 stddev:24.23 (17.0%) stddev-sans-first:25.42 02:37:31 INFO - PROCESS | 13459 | Values: 152.0 126.0 125.0 200.0 125.0 125.0 152.0 125.0 157.0 133.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:2.45 (1.5%) stddev-sans-first:2.52 02:37:31 INFO - PROCESS | 13459 | Values: 160.0 161.0 160.0 160.0 161.0 162.0 162.0 163.0 168.0 160.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#3] audio-fft Cycles:10 Average:86.90 Median:75.50 stddev:24.30 (32.2%) stddev-sans-first:25.39 02:37:31 INFO - PROCESS | 13459 | Values: 75.0 76.0 76.0 140.0 75.0 76.0 75.0 76.0 125.0 75.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:92.00 stddev:23.76 (25.8%) stddev-sans-first:24.61 02:37:31 INFO - PROCESS | 13459 | Values: 92.0 92.0 158.0 93.0 94.0 94.0 128.0 91.0 92.0 131.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:37:31 INFO - PROCESS | 13459 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:37:31 INFO - PROCESS | 13459 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:37:31 INFO - PROCESS | 13459 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:56.00 stddev:15.97 (28.5%) stddev-sans-first:16.79 02:37:31 INFO - PROCESS | 13459 | Values: 56.0 56.0 57.0 55.0 63.0 56.0 56.0 107.0 58.0 56.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:1.85 (3.0%) stddev-sans-first:1.94 02:37:31 INFO - PROCESS | 13459 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 63.0 68.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.56 (2.0%) stddev-sans-first:1.66 02:37:31 INFO - PROCESS | 13459 | Values: 80.0 83.0 82.0 78.0 79.0 81.0 79.0 79.0 79.0 80.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:124.50 stddev:24.00 (19.3%) stddev-sans-first:25.46 02:37:31 INFO - PROCESS | 13459 | Values: 131.0 120.0 132.0 119.0 118.0 119.0 128.0 119.0 197.0 121.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.72 (1.7%) stddev-sans-first:2.88 02:37:31 INFO - PROCESS | 13459 | Values: 163.0 164.0 158.0 161.0 166.0 163.0 164.0 165.0 168.0 163.0 02:37:31 INFO - PROCESS | 13459 | 02:37:31 INFO - PROCESS | 13459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.50 stddev:2.78 (4.4%) stddev-sans-first:2.95 02:37:31 INFO - PROCESS | 13459 | Values: 63.0 62.0 66.0 62.0 63.0 61.0 62.0 62.0 61.0 70.0 02:37:31 INFO - PROCESS | 13459 | -------- Summary: end -------- 02:37:31 INFO - PROCESS | 13459 | 02:37:32 INFO - TEST-INFO | 13459: exit 0 02:37:32 INFO - TEST-OK | kraken | took 62881ms 02:37:32 INFO - SUITE-END | took 1175s 02:37:32 INFO - Completed test suite (00:19:35) 02:37:32 INFO - javascript benchmark 02:37:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.114187456575, 3110.5178697301926, 3132.107349405419, 3153.2274592724784, 3169.033444799337, 5246.947530524693, 5264.473552644734, 5414.675119492833, 5484.396716361202, 5506.972465137674, 5436.592255580827, 5437.755301011454, 5443.618946673734, 5446.2647542581735, 5542.61201715879, 4892.217245240762, 4926.679765815211, 4982.476839931809, 4992.950070499285, 5116.309298244745, 5028.924566131493, 5039.19372900336, 5064.0, 5087.211482220262, 5095.261187127864, 4794.904101917959, 4854.781534830923, 4867.805287788484, 4868.075065737534, 4932.0629080474955, 4869.707817530924, 4884.4871288514905, 4952.380952380952, 4983.750812459399, 5015.673981191211, 4720.457147428021, 4931.90136197274, 4932.186189278765, 4951.43058548268, 4968.90062198754, 5234.42421333653, 5255.054090263751, 5310.150375939831, 5345.224942383333, 5364.91952620711, 5757.856053598652, 5767.077267637158, 5797.275340582427, 5799.507041901444, 5801.53587712982, 5580.748866301026, 5710.942890571083, 5735.053716136832, 5777.537796976232, 5830.154627578977, 5414.83755487336, 5417.756200970965, 5419.674819510842, 5430.619856610039, 5439.0, 5941.346451890375, 5944.078667806497, 5957.165996760457, 5961.076033214858, 5961.821145365646, 5409.080456322435, 5656.4060773619, 5699.971500142473, 5706.229658995982, 5706.514946229617, 5817.650940943557, 5869.794557190563, 5870.26621672291, 5873.20711703923, 5885.588008839341, 5768.538516918637, 5781.566382521328, 5792.9420705793245, 5799.768009279666, 5817.243758311477, 5526.917096243559, 5709.942900571024, 5747.885042299131, 5763.711814409263, 5802.680852553066, 4407.471103467605, 4408.911821763547, 4409.0520538084465, 4420.115976804652, 4453.799579018952, 3766.8304926278383, 3934.7245692801803, 3938.6849052075763, 3958.5051868516434, 3963.3460479021214, 5429.972850135803, 5491.890162196733, 5492.5605951523785, 5497.120460726344, 5504.4770746778995, 5755.597108202385, 5771.0477771168125, 5791.391903850119, 5819.592628515963, 5880.14737863016, 5227.424983251915, 5339.0389729849, 5346.4386239445075, 5355.223492593552, 5360.3299587551555, 4907.975460122677, 4929.679570827885, 4932.67937584063, 4940.283658869444, 4965.925511117336, 5857.4435428634215, 5866.853328666817, 5868.765249389977, 5873.9412605873395, 5897.240827204832, 5608.10270356741, 5682.176084467812, 5697.202391665253, 5737.368889422244, 5785.0, 5846.152307915413, 5872.0, 5895.0, 5898.439648233411, 5911.083782013795, 5626.2967129108865, 5628.549716022627, 5630.577706671934, 5639.3232812062815, 5643.0, 5579.358373786904, 5666.9716651416475, 5670.914936275876, 5677.51741102011, 5724.542036637143, 5599.272094627672, 5603.607747457639, 5607.383187849415, 5613.887722245614, 5616.606837521498, 5541.889162216652, 5590.133529302964, 5597.04850175463, 5599.860003499782, 5605.159226116115, 5332.173513105475, 5502.972485137709, 5564.666120032811, 5585.581081418829, 5619.044762390322, 5700.201971723879, 5723.313202415737, 5740.39725828782, 5772.913406298825, 5774.364819869895, 5354.250404943389, 5595.63628364155, 5597.608167428241, 5607.383187849415, 5637.802676906289], "value": 5310.895819571304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5570677698504, 634.2547506679651, 647.4658406814376, 655.4723447624662, 661.4410822854692, 42025.369619455734, 43253.35119973203, 43255.13489730207, 43301.0, 46339.768301158445, 44489.77755111228, 45139.77430112845, 45152.322715159215, 45272.32091518622, 45439.77280113603, 8533.914660853405, 8660.566971651424, 8666.046734859161, 8675.95662021689, 8685.261752751023, 8698.304135669132, 8766.736997890042, 8798.648054077828, 8810.735677929672, 8819.51492667903, 8818.691345802898, 8879.733607991771, 8888.911110888874, 8890.822183556325, 8893.68872089477, 8774.956125219365, 8802.0, 8814.823703525894, 8823.558822058903, 8824.514651694155, 8786.253168480624, 8871.334649901282, 8875.289976801905, 8885.555722213863, 8889.377743557954, 39059.80470097631, 39158.0, 39393.212135757414, 39396.80301598473, 39480.0, 3533.823308834548, 3569.910752231215, 3596.730245231618, 3602.7297952653657, 4049.5343035550995, 31191.376172476652, 31383.843080784678, 31411.528827067614, 31471.37057258842, 32890.342193156, 4411.205982923073, 4459.888502787424, 4471.843485478025, 4537.769293700592, 4611.054733779567, 327889.0, 328334.0, 329667.0, 331979.0, 332658.0, 51945.220821687704, 57370.713146434, 58408.4159158403, 58617.706911466026, 60442.0, 63996.36003639997, 64092.679536602016, 64206.6789666058, 64369.0, 64479.0, 16800.91599542019, 16969.745453818203, 16972.32110715582, 16979.575510612085, 16986.830131698523, 10054.597816087275, 12855.614331570068, 12971.740565188833, 13069.803952940714, 13425.731485370237, 18372.632547348978, 18373.26506939734, 18385.724214136797, 18438.631227375376, 18513.90743046303, 6869.450443964471, 7081.398081163055, 7153.535020223669, 7182.0, 7199.640017999079, 928.1965826846044, 1067.8985496377832, 1135.2564070533813, 1136.091127098318, 1187.8633957095044, 31869.521957170662, 32995.505067424005, 33080.0, 35576.466353004726, 35703.28593428169, 1112.449337577904, 1118.2731224703846, 1136.4431428599926, 1153.4348169396935, 1168.9649310520697, 15998.9200053999, 16370.590735231715, 16391.590210244838, 16480.505584832474, 16566.337346506247, 469741.0, 471271.0, 473066.0, 475834.0, 476516.0, 54451.0, 55908.44091559033, 55913.44086559083, 56088.71955640196, 56106.71946640241, 1237.8205160251714, 1368.493657346788, 1387.7293927684207, 1397.4899161805868, 1416.122004357305, 30624.0, 32179.0, 32479.0, 32535.674643254213, 32925.0, 47714.28428573505, 48395.758021209665, 48421.75789121032, 48578.271325930844, 48614.513854861, 409710.0, 413480.0, 413538.0, 413766.0, 414334.0, 24051.639225411283, 26428.867855661367, 27102.238354506895, 27333.180004599893, 28221.294467638472, 44905.0, 45714.0, 45840.0, 45970.7701461504, 46774.298385524926, 35018.299634007686, 35098.649013510556, 35454.0, 36106.8194659025, 36354.0, 38526.036849079, 38678.0, 38886.6111338883, 38904.80547597244, 39187.6081239184, 38063.637316196044, 38557.807210963765, 38940.61059389483, 39154.6084539151, 39330.803345983084, 33796.831015844764, 35012.64987350094, 35401.468977965866, 35611.0, 35832.46251306285, 26667.599985999837, 26998.865005674845, 27031.862157192034, 27106.186814395598, 27212.31969200786], "value": 19767.723559121187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.31016325695373, 387.8041588997556, 388.6598141535306, 399.47668554194007, 412.9979350103249, 14238.28808559573, 15841.207939603002, 17725.911370443147, 19223.519412014688, 19228.519287017814, 17866.28534858604, 18654.906725466353, 18689.158987845545, 18766.43700688978, 19055.237790488398, 4958.603311735062, 5139.640225184238, 5683.147527870811, 5824.330202026778, 5833.8833223335505, 3919.098607320318, 5664.518515926131, 5684.573656975723, 5743.368229494752, 5978.581499295029, 6006.159137720722, 6006.489448396892, 6016.458518733313, 6023.247094113236, 6026.0960855871535, 5815.127730840365, 5959.10613407988, 5977.372375900533, 6014.96992515039, 6021.90967135489, 5629.324481062299, 5730.169125476824, 5747.109198074305, 5750.453706897838, 5753.338366087912, 21892.781072189235, 22341.664875026887, 22722.318330450114, 22737.545249095092, 22777.886110569507, 2246.7191601049867, 2252.0, 2325.8837058147024, 2418.4921166555046, 2792.567152091409, 13769.862301376957, 14276.214808185545, 14292.928535357256, 14398.640033999129, 14886.553403397915, 1870.9064546772743, 1895.1945423195086, 1903.038965322517, 1929.8359639430664, 1962.7644682638174, 77048.61475692641, 78936.0, 79981.0, 80977.19022809755, 82455.9999999994, 10930.289531180448, 10950.835737463944, 10954.123670106372, 11127.554897803997, 11155.888441115647, 13713.245771482465, 15739.842601574066, 15781.368745250062, 15806.288717007763, 31603.367932641217, 9727.173190278763, 9995.100440960348, 10023.448710320856, 10144.949275253577, 10307.536160872778, 8358.623861926228, 8386.329093672492, 8423.915760842436, 8461.830763384698, 8769.868451973225, 8661.696840610675, 8729.65081396737, 9011.369204155646, 9087.36388452802, 9205.309601779893, 3232.8383580821337, 3237.8219197943868, 3298.5321531918544, 3340.5824271966003, 3410.0963244740165, 883.885094937654, 910.2444970674325, 947.1712251779693, 975.2100798353215, 979.2410881566842, 17505.38731144404, 18155.27378904829, 18192.818071819376, 18280.725789113174, 18596.512279017916, 926.2682480840195, 929.400536653868, 938.5401153434768, 942.2320808541017, 963.1184051630323, 10160.4919754012, 10829.99166236555, 11778.646640600795, 11837.704057398461, 11847.703807404712, 177776.0, 178288.10855945636, 466610.0, 477703.0, 478583.0, 88701.0, 96414.0, 96796.0, 97718.0, 100759.49620251852, 1000.6797824696173, 1024.3904876598413, 1031.747221930632, 1039.4594810698395, 1051.4427353502808, 17202.397916072878, 17224.588862198336, 17277.049762263196, 17382.5654358637, 17448.73826892572, 28138.281253873924, 38549.0, 39230.607693923834, 39439.0, 42403.0, 57573.712131439075, 58284.70857645685, 59675.0, 60280.0, 60447.0, 8475.364347673825, 8573.271271941954, 8690.695825646071, 8757.0, 9103.226225770619, 11989.820152697543, 12716.427760750974, 12944.741105178033, 13215.933920330337, 13498.59504214875, 6122.112293717475, 11270.154738394489, 11504.0, 11513.366764828015, 11746.236494627821, 11201.831972520256, 11230.887691122984, 11333.376664283544, 11463.656090317303, 11569.595064172714, 11516.366599837089, 11682.24065435744, 11718.414079296172, 11738.471768770254, 11970.521179152736, 8673.522956237468, 8777.692780752643, 8959.41763785352, 9103.954480227556, 9154.0, 7870.252326029018, 8061.113277539584, 8063.959680201561, 8087.595620218848, 8325.708600198965], "value": 9449.010426892259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.6354502511815, 1461.9926900365497, 1487.6727120033593, 1633.5344426838353, 1801.7297405389197, 7837.686492540299, 8189.0, 8203.958980205105, 8387.287080598142, 8395.748127556168, 8199.057108432517, 8347.290480309166, 8362.08017118118, 8370.204830541104, 8370.246677798998, 2000.0999550202466, 2239.0, 2300.723913130427, 2331.6036273833406, 2336.9766302337016, 2348.9295321140307, 2356.2931120663816, 2364.869932153731, 2365.47959448921, 2369.893354799038, 2245.236619549353, 2292.988535057322, 2300.056976639578, 2302.792748652621, 2307.215546714117, 1989.2242025610024, 2224.3549370682404, 2280.258915852338, 2281.167373908528, 2295.357299956015, 2174.1629472652985, 2183.3231698173618, 2192.78072192781, 2194.2758889566403, 2203.768604296558, 8251.917480825176, 8288.171182881664, 8302.377321700897, 8323.209295117014, 8327.417080804345, 4910.165271903785, 5036.6726162799305, 5041.521055499722, 5051.116054690451, 5051.368578927634, 3167.5407065975537, 3216.372807302577, 3242.1084201844446, 3253.235489659928, 3257.088015355704, 1056.730533713898, 1060.3796778884362, 1066.344198318029, 1079.5357996061691, 1080.6109800471825, 11615.6515304541, 11625.767484650345, 11643.476043577975, 11648.184627076109, 11663.241889277255, 4410.272305069691, 4434.157510073076, 4503.301988191835, 4508.909821803545, 4624.398828152319, 9778.364406313567, 9778.75553111178, 9787.021297870298, 9793.657221997339, 9811.901880981242, 4567.566081222279, 5198.636095473281, 5201.505856943584, 5214.191800270964, 5220.477952204825, 4634.050019745944, 4714.905701886011, 4764.785584648699, 4808.639352048541, 4816.325714399987, 3699.2416554606243, 3823.0824602095295, 3823.1589050408866, 3856.8842934712, 3898.863539776151, 1223.614561413152, 1236.5733821831454, 1238.9442475088642, 1247.6631309546372, 1255.1026016398318, 786.5791801386231, 884.1467983395925, 894.8478758611052, 911.48956584313, 916.6699988004314, 5291.867703307448, 5323.121684922022, 5395.109806881899, 5448.0, 5592.720363981784, 414.345334371692, 428.42804855518233, 435.40567125872957, 437.78767297860514, 445.888527868033, 3605.94591081134, 3662.066173125836, 3724.3296206682517, 3732.794696291676, 3753.0992561784974, 9837.950810246046, 10097.848532272023, 10314.690559283234, 10320.48397580133, 10341.327813692085, 10174.440405777605, 10247.0, 10257.0, 10279.280450368551, 10306.433146176882, 7788.337991270692, 7797.493162944391, 7864.646090925922, 7939.285464308125, 7951.324137448266, 5346.759395827119, 5349.1976203569775, 5437.90175894215, 5500.367457742411, 5512.614117011931, 9463.905360946303, 9518.333716640045, 9560.76098097553, 9566.330356874952, 9592.08875156859, 9099.0, 9538.85691714611, 9546.761330966503, 9803.607855685692, 9856.31005829585, 6775.525713200029, 7239.963800180965, 7408.111026676834, 7542.47202695806, 7708.421868359784, 7780.2219778021745, 7789.493682910593, 7854.586174488647, 7855.33229675484, 7858.13560508355, 6817.420519255918, 6899.6205208714, 7054.329838665319, 7153.4992550520965, 7205.855882882418, 6660.134182556237, 6673.666316684244, 6741.494387920828, 6833.487488438288, 7009.859802803813, 6281.403266689657, 6291.465225455888, 6295.5907865988565, 6396.712147953446, 6437.25971513282, 4657.930131048105, 4671.696339737906, 4675.509071547439, 4707.552782485658, 4769.046190761792, 4467.553244675636, 4531.504603480909, 4541.591256786905, 4638.026014536985, 4639.652026097989], "value": 4292.906515967355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.4522686550775, 319.7633751024242, 324.2024619436187, 325.9625143108543, 326.9934601307973, 4921.901561968759, 5082.923756143661, 5322.308099947007, 5323.9733801330985, 5324.600654950879, 5242.895142097156, 5283.6037297202765, 5284.682919024861, 5284.894302113956, 5296.3379577552805, 4113.9794301028605, 4134.7725875076785, 4155.189738001091, 4161.625453709165, 4189.266878296301, 3960.267350540145, 4054.736442131267, 4134.607212314841, 4154.335306350985, 4164.83340666373, 4093.9385909211387, 4094.34490481523, 4096.467459230296, 4096.918061638766, 4100.1594673092095, 4146.0, 4146.979265103685, 4155.91688166235, 4175.5615660355525, 4179.707420480568, 3423.880164194266, 3666.651668091527, 3705.7776533407814, 3718.888433347004, 3721.4789929409903, 5064.139096353629, 5093.286939828427, 5105.340764251633, 5127.9743601282125, 5141.948580514184, 4617.252734622894, 4630.356223540662, 4631.305304204397, 4636.976815115937, 4646.930296045562, 5308.416074231832, 5461.69960652164, 5501.872116216206, 5503.7798488060425, 5528.115501519777, 3922.7447216890605, 3925.450436938831, 3930.1746633207063, 3932.2528719543197, 3933.606639336072, 5484.369297530795, 5548.722563871831, 5694.601377903548, 5712.514746165985, 5791.247137872049, 3892.5328960524353, 3899.4735710678697, 3915.9804200979383, 3932.724709270381, 3933.6853051755793, 3960.5247370315747, 3982.203559288154, 3983.4423180754716, 3993.121513267077, 3996.680265578747, 4580.244259697112, 4599.033044312135, 4603.516630753789, 4605.930911036337, 4618.237990731559, 5250.448702886219, 5517.5585953123655, 5534.889302214014, 5567.608097975506, 5574.0, 1390.2978995607155, 1401.5515035188641, 1406.7186562687502, 1407.985920140806, 1414.2009764483034, 848.5841937450605, 896.3591032411857, 899.9910000899907, 913.8355096082769, 917.3395155488038, 4678.017616300547, 4807.4471435784635, 4814.5907597854575, 4855.393075865446, 4858.295547145644, 5001.249812528077, 5028.748562571856, 5052.974735126374, 5070.7464626768515, 5088.465711100281, 4779.832705855279, 4785.49752276013, 4815.3258543803895, 4833.951660483421, 4997.750112494434, 3013.3973205359016, 3018.5623084652602, 3026.0014195315935, 3027.3339865229614, 3046.482098043338, 5871.941280587225, 5874.50066744323, 5880.0, 5919.200907877467, 5929.738643745923, 5556.527695145958, 5762.88474230513, 5770.9414010574465, 5794.30468343793, 5802.854928626733, 5791.5656325775735, 5828.504577110908, 5842.883142337129, 5884.58807883444, 5913.497352725067, 5416.51251387377, 5648.237487939075, 5689.914651280317, 5813.738381772915, 5817.447342502455, 5628.60599758013, 5690.601657883908, 5704.743286552198, 5712.5429965601825, 5715.399883012224, 5614.129809879475, 5705.686187259741, 5857.209276747584, 5874.353821079592, 5879.412058794086, 3960.9107495438984, 3964.266610677034, 3977.8607748728655, 3997.5402828675074, 3998.9805148399873, 5704.401037890962, 5705.657660540381, 5735.627184233012, 5755.8561035974435, 5769.8557536061935, 5336.439673834191, 5510.256115424367, 5536.252605898313, 5557.388687244319, 5568.860778480408, 5460.0, 5510.448955104457, 5557.41647127062, 5559.555235581225, 5574.163875418558, 5271.894562108813, 5469.632591852037, 5481.890362192654, 5497.972510137583, 5501.174823776466, 5564.582656300713, 5623.971880140573, 5627.971860140673, 5647.830565083054, 5658.726786473011, 5512.6968016759465, 5532.1425179097305, 5540.196671482693, 5542.861428464159, 5544.833654990357], "value": 4166.08017146217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.7808677417744, 851.9233269005788, 861.5692153923038, 863.7063398444532, 890.2788741119693, 13438.731225375499, 13594.592162235123, 13607.523736669205, 13616.183029018266, 13628.659283517916, 12263.141580089397, 12601.054920880948, 12701.428435720392, 12726.554570590031, 12756.0, 819.1071731812324, 819.8934138561979, 823.567626995826, 825.1253671108614, 826.9917300827005, 680.7855525509449, 790.6244533846406, 809.995950020252, 813.5810057820198, 817.0767033252446, 852.6845067325098, 860.4536119564091, 862.2670729879615, 862.3144600042981, 862.4221771413169, 858.51064893011, 858.8196478739472, 858.9742307730778, 859.4585411190973, 859.9355048371397, 519.8674338043775, 605.9575829691923, 624.4192900602438, 624.815679374581, 626.3767551286454, 13553.59339219815, 13566.932165339209, 13579.321033948263, 13595.184288942695, 13628.523001694992, 13153.53962611304, 13347.399367028507, 13538.526151584647, 13577.59267221985, 13652.180869147884, 12544.498220071186, 12574.68563285916, 12599.0, 12715.30065846378, 12808.0, 4360.825566977317, 4375.890602734925, 4396.120775844812, 4429.889252768674, 4475.888102797424, 59516.40483595152, 59848.40151598472, 59879.401205987815, 60109.6994515029, 62163.689181554255, 10533.315334503233, 10737.409442480583, 10866.239363244655, 10988.890111098946, 11041.39272340029, 19400.2239910402, 19477.12352944121, 19507.707384389247, 19510.804891951182, 19693.0, 8164.673413063411, 8188.303994160563, 8322.916770832335, 8409.41134120618, 8564.357673174536, 4632.374629425052, 4659.6505262105475, 4686.81252749893, 4725.669203155746, 4859.829905953275, 3284.261041265696, 3358.596968363763, 3361.6302206757236, 3378.054144839449, 3384.9323013540084, 571.6770024935898, 577.3995045152993, 581.3575998521573, 583.7577405376805, 585.7569108819793, 696.9372756451944, 700.831800367908, 707.0525495835604, 712.1383126417094, 724.3770357492552, 8643.438176518506, 8713.651453941771, 8913.866292005625, 8942.821143577092, 9519.095685909828, 673.0, 700.4011570107587, 702.1328659106, 708.1749761527865, 713.9178994415605, 4234.216669916075, 4249.213895429355, 4259.297215959394, 4279.33670281107, 4324.870253892388, 68482.0, 69040.0, 69252.653736731, 69339.0, 69345.0, 59645.701771490865, 60483.69758151269, 61021.69489152526, 61069.38930610637, 62161.37838621556, 56166.438335616935, 56340.43659563434, 56420.153697694564, 56421.71789141028, 56813.147802782994, 7946.8807967881685, 8006.639701213576, 8060.073091594541, 8164.0, 8223.835523289381, 38092.80953595214, 38119.237615248094, 38143.42784858174, 38282.42576361413, 38513.91888648958, 47550.76224618855, 50670.74664626653, 50867.23699144442, 51305.7434712824, 53039.20441193308, 10379.584816607252, 10486.37081775096, 10552.366857988545, 10722.517486713272, 10786.784264314827, 11699.707507312045, 11758.70603234926, 11961.162718609614, 12331.198472099644, 12417.379131043592, 9043.728688139103, 10674.758300756928, 10793.514291856729, 11061.889381106086, 12503.187292825936, 12698.936505317415, 13366.131201471873, 13424.261665608095, 13551.390187441786, 13915.791263131263, 11747.530098796295, 11809.704757381134, 12031.4585843639, 12060.0, 12499.250044997329, 9533.90466095358, 9642.903570964201, 10017.599296028076, 10084.94957525237, 10257.28199026061, 9882.851757223503, 10287.82788151901, 10432.426216558162, 10446.582136714751, 10461.163106951273], "value": 6738.156212896846, "unit": "score"}], "name": "dromaeo_css", "value": 7018.805377031044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 111.0, 112.0, 110.0, 109.0, 110.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 125.0, 200.0, 125.0, 125.0, 152.0, 125.0, 157.0, 133.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 163.0, 168.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 140.0, 75.0, 76.0, 75.0, 76.0, 125.0, 75.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 158.0, 93.0, 94.0, 94.0, 128.0, 91.0, 92.0, 131.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 63.0, 56.0, 56.0, 107.0, 58.0, 56.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 68.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 82.0, 78.0, 79.0, 81.0, 79.0, 79.0, 79.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 132.0, 119.0, 118.0, 119.0, 128.0, 119.0, 197.0, 121.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 158.0, 161.0, 166.0, 163.0, 164.0, 165.0, 168.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 62.0, 63.0, 61.0, 62.0, 62.0, 61.0, 70.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1527.4000000000003, "alertThreshold": 2.0}]} 02:37:32 INFO - Return code: 0 02:37:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:37:32 ERROR - # TBPL SUCCESS # 02:37:32 INFO - Running post-action listener: _resource_record_post_action 02:37:32 INFO - ##### 02:37:32 INFO - ##### Finished run-tests step (success) 02:37:32 INFO - ##### 02:37:32 INFO - Running post-run listener: _resource_record_post_run 02:37:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538431488; Read time: 8; Write time: 414312 02:37:33 INFO - TinderboxPrint: CPU usage
13.1% 02:37:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:37:33 INFO - TinderboxPrint: I/O write bytes / time
538,431,488 / 414,312 02:37:33 INFO - TinderboxPrint: CPU idle
8,270.9 (86.9%) 02:37:33 INFO - TinderboxPrint: CPU user
1,208.1 (12.7%) 02:37:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:37:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253759488; Read time: 0; Write time: 246176 02:37:33 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284672000; Read time: 8; Write time: 168136 02:37:33 INFO - Running post-run listener: _upload_blobber_files 02:37:33 INFO - Blob upload gear active. 02:37:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:37:33 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 02:37:33 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'] 02:37:33 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 02:37:33 INFO - (blobuploader) - INFO - Open directory for files ... 02:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:38 INFO - (blobuploader) - INFO - Done attempting. 02:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:38 INFO - (blobuploader) - INFO - Done attempting. 02:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:39 INFO - (blobuploader) - INFO - Done attempting. 02:37:39 INFO - (blobuploader) - INFO - Iteration through files over. 02:37:39 INFO - Return code: 0 02:37:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:37:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:37:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58679ed442106934b2149e76940562717cd7555aae608f84f62a2ba9a63246db85a7557f377f6803764ee148b758b5badf2e113b742d791613de319a8b4f52ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c753e5f176d31fa3bd5fbe407efb216b82b53e115a8163f5c8203cba89fbabfbb5902786096860516aca4b00f00ba12d87d3395cb4922e87b5d75ddfab1fc268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1a2824f817ed5cfef6ae0c04af948485a5c7a5dae4fb449261d9a749555c1b0b55933951c16fb64c564ef01bf1344319491c42102d6bcd8af7200b989ecaa67"} 02:37:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:37:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:37:39 INFO - Contents: 02:37:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58679ed442106934b2149e76940562717cd7555aae608f84f62a2ba9a63246db85a7557f377f6803764ee148b758b5badf2e113b742d791613de319a8b4f52ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c753e5f176d31fa3bd5fbe407efb216b82b53e115a8163f5c8203cba89fbabfbb5902786096860516aca4b00f00ba12d87d3395cb4922e87b5d75ddfab1fc268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1a2824f817ed5cfef6ae0c04af948485a5c7a5dae4fb449261d9a749555c1b0b55933951c16fb64c564ef01bf1344319491c42102d6bcd8af7200b989ecaa67"} 02:37:39 INFO - Running post-run listener: copy_logs_to_upload_dir 02:37:39 INFO - Copying logs to upload dir... 02:37:39 INFO - mkdir: /builds/slave/test/build/upload/logs 02:37:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.634036 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-24 02:37:39.420086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:37:39.424444) ========= 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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 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/58679ed442106934b2149e76940562717cd7555aae608f84f62a2ba9a63246db85a7557f377f6803764ee148b758b5badf2e113b742d791613de319a8b4f52ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c753e5f176d31fa3bd5fbe407efb216b82b53e115a8163f5c8203cba89fbabfbb5902786096860516aca4b00f00ba12d87d3395cb4922e87b5d75ddfab1fc268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1a2824f817ed5cfef6ae0c04af948485a5c7a5dae4fb449261d9a749555c1b0b55933951c16fb64c564ef01bf1344319491c42102d6bcd8af7200b989ecaa67"} build_url:https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/Lx35Q6dBQL6WjOVjTAYjPA/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/58679ed442106934b2149e76940562717cd7555aae608f84f62a2ba9a63246db85a7557f377f6803764ee148b758b5badf2e113b742d791613de319a8b4f52ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c753e5f176d31fa3bd5fbe407efb216b82b53e115a8163f5c8203cba89fbabfbb5902786096860516aca4b00f00ba12d87d3395cb4922e87b5d75ddfab1fc268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1a2824f817ed5cfef6ae0c04af948485a5c7a5dae4fb449261d9a749555c1b0b55933951c16fb64c564ef01bf1344319491c42102d6bcd8af7200b989ecaa67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:37:39.456990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:37:39.457637) ========= 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=523ca41ca1e0623de333ad52000001bf-1464081422.558655-1879652026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:37:39.540701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:37:39.541155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:37:39.541585) ========= ========= Total master_lag: 0.17 =========