builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1464682637.83 results: success (0) buildid: 20160530220813 builduid: 2ae87841ae054616b2dbfc0970452eba revision: 11bba688023e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.829444) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.829900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.830207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.845719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.846050) ========= 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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 01:17:18-- 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% 38.4M=0s 2016-05-31 01:17:18 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.971882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:17.972192) ========= 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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.022580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.022940) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11bba688023e --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 11bba688023e --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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 01:17:18,765 Setting DEBUG logging. 2016-05-31 01:17:18,765 attempt 1/10 2016-05-31 01:17:18,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11bba688023e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 01:17:19,078 unpacking tar archive at: fx-team-11bba688023e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.698524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.698854) ========= script_repo_revision: 11bba688023e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.699241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.699503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 01:17:18.708878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 01:17:18.709152) ========= /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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:17:19 INFO - MultiFileLogger online at 20160531 01:17:19 in /builds/slave/test 01:17:19 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 01:17:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:17:19 INFO - {'append_to_log': False, 01:17:19 INFO - 'base_work_dir': '/builds/slave/test', 01:17:19 INFO - 'blob_upload_branch': 'Fx-Team', 01:17:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:17:19 INFO - 'branch': 'Fx-Team', 01:17:19 INFO - 'buildbot_json_path': 'buildprops.json', 01:17:19 INFO - 'config_files': ('talos/linux_config.py',), 01:17:19 INFO - 'default_actions': ('clobber', 01:17:19 INFO - 'read-buildbot-config', 01:17:19 INFO - 'download-and-extract', 01:17:19 INFO - 'populate-webroot', 01:17:19 INFO - 'create-virtualenv', 01:17:19 INFO - 'install', 01:17:19 INFO - 'run-tests'), 01:17:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:17:19 INFO - 'download_minidump_stackwalk': True, 01:17:19 INFO - 'download_symbols': 'ondemand', 01:17:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:17:19 INFO - 'tooltool.py': '/tools/tooltool.py', 01:17:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:17:19 INFO - '/tools/misc-python/virtualenv.py')}, 01:17:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:17:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:17:19 INFO - 'installer_path': 'installer.exe', 01:17:19 INFO - 'log_level': 'info', 01:17:19 INFO - 'log_name': 'talos', 01:17:19 INFO - 'log_to_console': True, 01:17:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:17:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:17:19 INFO - 'opt_config_files': (), 01:17:19 INFO - 'pip_index': False, 01:17:19 INFO - 'sps_profile': False, 01:17:19 INFO - 'sps_profile_interval': 0, 01:17:19 INFO - 'suite': 'dromaeojs', 01:17:19 INFO - 'system_bits': '32', 01:17:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:17:19 INFO - 'title': 'talos-linux64-ix-020', 01:17:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:17:19 INFO - 'use_talos_json': True, 01:17:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:17:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:17:19 INFO - 'work_dir': 'build'} 01:17:19 INFO - ##### 01:17:19 INFO - ##### Running clobber step. 01:17:19 INFO - ##### 01:17:19 INFO - Running pre-action listener: _resource_record_pre_action 01:17:19 INFO - Running main action method: clobber 01:17:19 INFO - rmtree: /builds/slave/test/build 01:17:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:17:20 INFO - Running post-action listener: _resource_record_post_action 01:17:20 INFO - ##### 01:17:20 INFO - ##### Finished clobber step (success) 01:17:20 INFO - ##### 01:17:20 INFO - ##### 01:17:20 INFO - ##### Running read-buildbot-config step. 01:17:20 INFO - ##### 01:17:20 INFO - Running pre-action listener: _resource_record_pre_action 01:17:20 INFO - Running main action method: read_buildbot_config 01:17:20 INFO - Using buildbot properties: 01:17:20 INFO - { 01:17:20 INFO - "project": "", 01:17:20 INFO - "product": "firefox", 01:17:20 INFO - "script_repo_revision": "production", 01:17:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:17:20 INFO - "repository": "", 01:17:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:17:20 INFO - "buildid": "20160530220813", 01:17:20 INFO - "pgo_build": "True", 01:17:20 INFO - "basedir": "/builds/slave/test", 01:17:20 INFO - "buildnumber": 1204, 01:17:20 INFO - "slavename": "talos-linux64-ix-020", 01:17:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:17:20 INFO - "platform": "ubuntu64_hw", 01:17:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:17:20 INFO - "branch": "fx-team", 01:17:20 INFO - "repo_path": "integration/fx-team", 01:17:20 INFO - "revision": "11bba688023e", 01:17:20 INFO - "stage_platform": "linux64-pgo", 01:17:20 INFO - "builduid": "2ae87841ae054616b2dbfc0970452eba", 01:17:20 INFO - "slavebuilddir": "test" 01:17:20 INFO - } 01:17:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:17:20 INFO - Running post-action listener: _resource_record_post_action 01:17:20 INFO - ##### 01:17:20 INFO - ##### Finished read-buildbot-config step (success) 01:17:20 INFO - ##### 01:17:20 INFO - ##### 01:17:20 INFO - ##### Running download-and-extract step. 01:17:20 INFO - ##### 01:17:20 INFO - Running pre-action listener: _resource_record_pre_action 01:17:20 INFO - Running main action method: download_and_extract 01:17:20 INFO - mkdir: /builds/slave/test/build/tests 01: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')]} 01:17:20 INFO - https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:21 INFO - Downloaded 1361 bytes. 01:17:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:17:21 INFO - Using the following test package requirements: 01:17:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:17:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:17:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:17:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'jsshell-linux-x86_64.zip'], 01:17:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:17:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:17:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:17:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:17:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:17:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:17:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:21 INFO - https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:22 INFO - Downloaded 24410762 bytes. 01:17:22 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'] 01:17:22 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 01:17:23 INFO - Return code: 0 01:17:23 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 01: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')]} 01:17:23 INFO - https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:24 INFO - Downloaded 24410762 bytes. 01:17:24 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'] 01:17:24 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 01:17:27 INFO - Return code: 0 01:17:27 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')]} 01:17:27 INFO - https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:28 INFO - Downloaded 10834055 bytes. 01:17:28 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'] 01:17:28 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 01:17:28 INFO - Return code: 0 01:17:28 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')]} 01:17:28 INFO - https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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 01:17:29 INFO - Downloaded 58938542 bytes. 01:17:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:17:29 INFO - mkdir: /builds/slave/test/properties 01:17:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:17:29 INFO - Writing to file /builds/slave/test/properties/build_url 01:17:29 INFO - Contents: 01:17:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:17:30 INFO - Running post-action listener: _resource_record_post_action 01:17:30 INFO - Running post-action listener: set_extra_try_arguments 01:17:30 INFO - ##### 01:17:30 INFO - ##### Finished download-and-extract step (success) 01:17:30 INFO - ##### 01:17:30 INFO - ##### 01:17:30 INFO - ##### Running populate-webroot step. 01:17:30 INFO - ##### 01:17:30 INFO - Running pre-action listener: _resource_record_pre_action 01:17:30 INFO - Running main action method: populate_webroot 01:17:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:17:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:17:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:17:30 INFO - '--tppagecycles', 01:17:30 INFO - '7'], 01:17:30 INFO - 'tests': ['tsvgm']}}, 01:17:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:17:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:17:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:17:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:17:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['damp', 'tps']}, 01:17:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'tests': ['damp', 'tps']}, 01:17:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['dromaeo_dom']}, 01:17:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:17:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'other-e10s': {'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['a11yr', 01:17:30 INFO - 'ts_paint', 01:17:30 INFO - 'tpaint', 01:17:30 INFO - 'sessionrestore', 01:17:30 INFO - 'sessionrestore_no_auto_restore', 01:17:30 INFO - 'tabpaint']}, 01:17:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['tsvgx', 01:17:30 INFO - 'tsvgr_opacity', 01:17:30 INFO - 'tart', 01:17:30 INFO - 'tscrollx', 01:17:30 INFO - 'cart']}, 01:17:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:17:30 INFO - 'tsvgr_opacity', 01:17:30 INFO - 'tart', 01:17:30 INFO - 'tscrollx', 01:17:30 INFO - 'cart']}, 01:17:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'talos_options': ['--disable-e10s'], 01:17:30 INFO - 'tests': ['tp5o']}, 01:17:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'tests': ['tp5o']}, 01:17:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'talos_options': ['--disable-e10s', 01:17:30 INFO - '--xperf_path', 01:17:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:30 INFO - 'tests': ['tp5n']}, 01:17:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:30 INFO - 'talos_options': ['--xperf_path', 01:17:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:30 INFO - 'tests': ['tp5n']}}, 01:17:30 INFO - 'talos.zip': {'path': '', 01:17:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:17:30 INFO - Running post-action listener: _resource_record_post_action 01:17:30 INFO - ##### 01:17:30 INFO - ##### Finished populate-webroot step (success) 01:17:30 INFO - ##### 01:17:30 INFO - ##### 01:17:30 INFO - ##### Running create-virtualenv step. 01:17:30 INFO - ##### 01:17:30 INFO - Running pre-action listener: _resource_record_pre_action 01:17:30 INFO - Running main action method: create_virtualenv 01:17:30 INFO - Creating virtualenv /builds/slave/test/build/venv 01:17:30 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 01:17:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:17:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:17:30 INFO - Using real prefix '/usr' 01:17:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:17:31 INFO - Installing distribute.............................................................................................................................................................................................done. 01:17:32 INFO - Installing pip.................done. 01:17:33 INFO - Return code: 0 01:17:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01: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', 'pip>=1.5'] in /builds/slave/test/build 01: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 pip>=1.5 01:17:33 INFO - Using env: {'DISPLAY': ':0', 01:17:33 INFO - 'HOME': '/home/cltbld', 01:17:33 INFO - 'LANG': 'en_US.UTF-8', 01:17:33 INFO - 'LANGUAGE': 'en_US:en', 01:17:33 INFO - 'LOGNAME': 'cltbld', 01:17:33 INFO - 'MAIL': '/var/mail/cltbld', 01:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:33 INFO - 'MOZ_NO_REMOTE': '1', 01:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:33 INFO - 'NO_EM_RESTART': '1', 01:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:33 INFO - 'PWD': '/builds/slave/test', 01:17:33 INFO - 'SHELL': '/bin/bash', 01:17:33 INFO - 'SHLVL': '1', 01:17:33 INFO - 'TERM': 'linux', 01:17:33 INFO - 'TMOUT': '86400', 01:17:33 INFO - 'USER': 'cltbld', 01:17:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:33 INFO - '_': '/tools/buildbot/bin/python'} 01:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:33 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 01:17:33 INFO - Cleaning up... 01:17:33 INFO - Return code: 0 01:17:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', '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 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01: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 psutil>=3.1.1 01:17:33 INFO - Using env: {'DISPLAY': ':0', 01:17:33 INFO - 'HOME': '/home/cltbld', 01:17:33 INFO - 'LANG': 'en_US.UTF-8', 01:17:33 INFO - 'LANGUAGE': 'en_US:en', 01:17:33 INFO - 'LOGNAME': 'cltbld', 01:17:33 INFO - 'MAIL': '/var/mail/cltbld', 01:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:33 INFO - 'MOZ_NO_REMOTE': '1', 01:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:33 INFO - 'NO_EM_RESTART': '1', 01:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:33 INFO - 'PWD': '/builds/slave/test', 01:17:33 INFO - 'SHELL': '/bin/bash', 01:17:33 INFO - 'SHLVL': '1', 01:17:33 INFO - 'TERM': 'linux', 01:17:33 INFO - 'TMOUT': '86400', 01:17:33 INFO - 'USER': 'cltbld', 01:17:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:33 INFO - '_': '/tools/buildbot/bin/python'} 01:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:33 INFO - Downloading/unpacking psutil>=3.1.1 01: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 01: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 01: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 01: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 01: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 01: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 01:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:35 INFO - Installing collected packages: psutil 01:17:35 INFO - Running setup.py install for psutil 01:17:35 INFO - building 'psutil._psutil_linux' extension 01:17:35 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 01:17:35 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 01:17:35 INFO - building 'psutil._psutil_posix' extension 01:17:35 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 01:17:35 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 01:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:35 INFO - Successfully installed psutil 01:17:35 INFO - Cleaning up... 01:17:36 INFO - Return code: 0 01:17:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01: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 mozsystemmonitor==0.3 01:17:36 INFO - Using env: {'DISPLAY': ':0', 01:17:36 INFO - 'HOME': '/home/cltbld', 01:17:36 INFO - 'LANG': 'en_US.UTF-8', 01:17:36 INFO - 'LANGUAGE': 'en_US:en', 01:17:36 INFO - 'LOGNAME': 'cltbld', 01:17:36 INFO - 'MAIL': '/var/mail/cltbld', 01:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:36 INFO - 'MOZ_NO_REMOTE': '1', 01:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:36 INFO - 'NO_EM_RESTART': '1', 01:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:36 INFO - 'PWD': '/builds/slave/test', 01:17:36 INFO - 'SHELL': '/bin/bash', 01:17:36 INFO - 'SHLVL': '1', 01:17:36 INFO - 'TERM': 'linux', 01:17:36 INFO - 'TMOUT': '86400', 01:17:36 INFO - 'USER': 'cltbld', 01:17:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:36 INFO - '_': '/tools/buildbot/bin/python'} 01:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 01: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 01: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 01: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 01: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 01: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 01: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 01:17:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:17:38 INFO - Installing collected packages: mozsystemmonitor 01:17:38 INFO - Running setup.py install for mozsystemmonitor 01:17:38 INFO - Successfully installed mozsystemmonitor 01:17:38 INFO - Cleaning up... 01:17:38 INFO - Return code: 0 01:17:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:17:38 INFO - Using env: {'DISPLAY': ':0', 01:17:38 INFO - 'HOME': '/home/cltbld', 01:17:38 INFO - 'LANG': 'en_US.UTF-8', 01:17:38 INFO - 'LANGUAGE': 'en_US:en', 01:17:38 INFO - 'LOGNAME': 'cltbld', 01:17:38 INFO - 'MAIL': '/var/mail/cltbld', 01:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:38 INFO - 'MOZ_NO_REMOTE': '1', 01:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:38 INFO - 'NO_EM_RESTART': '1', 01:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:38 INFO - 'PWD': '/builds/slave/test', 01:17:38 INFO - 'SHELL': '/bin/bash', 01:17:38 INFO - 'SHLVL': '1', 01:17:38 INFO - 'TERM': 'linux', 01:17:38 INFO - 'TMOUT': '86400', 01:17:38 INFO - 'USER': 'cltbld', 01:17:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:38 INFO - '_': '/tools/buildbot/bin/python'} 01:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:38 INFO - Downloading/unpacking blobuploader==1.2.4 01: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 01: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 01: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 01: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 01: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 01: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 01:17:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:17:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:17:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:41 INFO - Downloading docopt-0.6.1.tar.gz 01:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:17:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:17:41 INFO - Running setup.py install for blobuploader 01:17:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:17:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:17:41 INFO - Running setup.py install for requests 01:17:41 INFO - Running setup.py install for docopt 01:17:41 INFO - Successfully installed blobuploader requests docopt 01:17:41 INFO - Cleaning up... 01:17:41 INFO - Return code: 0 01:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 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 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:41 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 01:17:41 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 01:17:41 INFO - Using env: {'DISPLAY': ':0', 01:17:41 INFO - 'HOME': '/home/cltbld', 01:17:41 INFO - 'LANG': 'en_US.UTF-8', 01:17:41 INFO - 'LANGUAGE': 'en_US:en', 01:17:41 INFO - 'LOGNAME': 'cltbld', 01:17:41 INFO - 'MAIL': '/var/mail/cltbld', 01:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:41 INFO - 'MOZ_NO_REMOTE': '1', 01:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:41 INFO - 'NO_EM_RESTART': '1', 01:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:41 INFO - 'PWD': '/builds/slave/test', 01:17:41 INFO - 'SHELL': '/bin/bash', 01:17:41 INFO - 'SHLVL': '1', 01:17:41 INFO - 'TERM': 'linux', 01:17:41 INFO - 'TMOUT': '86400', 01:17:41 INFO - 'USER': 'cltbld', 01:17:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:41 INFO - '_': '/tools/buildbot/bin/python'} 01:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:41 INFO - Running setup.py (path:/tmp/pip-ZAR29Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:42 INFO - Running setup.py (path:/tmp/pip-AA0T3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:42 INFO - Running setup.py (path:/tmp/pip-wV4Otz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:42 INFO - Running setup.py (path:/tmp/pip-37jH12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:42 INFO - Running setup.py (path:/tmp/pip-E1ZXub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:42 INFO - Running setup.py (path:/tmp/pip-cf8aRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:42 INFO - Running setup.py (path:/tmp/pip-4tGFFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:42 INFO - Running setup.py (path:/tmp/pip-2tc1g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:42 INFO - Running setup.py (path:/tmp/pip-vonOzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:42 INFO - Running setup.py (path:/tmp/pip-TMkmj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:42 INFO - Running setup.py (path:/tmp/pip-BHLLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:42 INFO - Running setup.py (path:/tmp/pip-NKdEf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:42 INFO - Running setup.py (path:/tmp/pip-czMcLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:42 INFO - Running setup.py (path:/tmp/pip-zVUUfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:42 INFO - Running setup.py (path:/tmp/pip-sCMPYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:43 INFO - Running setup.py (path:/tmp/pip-Z1qOdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:43 INFO - Running setup.py (path:/tmp/pip-uYsgRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:17:43 INFO - Running setup.py install for manifestparser 01:17:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Running setup.py install for mozcrash 01:17:43 INFO - Running setup.py install for mozdebug 01:17:43 INFO - Running setup.py install for mozdevice 01:17:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Running setup.py install for mozfile 01:17:43 INFO - Running setup.py install for mozhttpd 01:17:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Running setup.py install for mozinfo 01:17:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Running setup.py install for mozInstall 01:17:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:17:43 INFO - Running setup.py install for mozleak 01:17:44 INFO - Running setup.py install for mozlog 01:17:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Running setup.py install for moznetwork 01:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Running setup.py install for mozprocess 01:17:44 INFO - Running setup.py install for mozprofile 01:17:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Running setup.py install for mozrunner 01:17:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Running setup.py install for mozscreenshot 01:17:44 INFO - Running setup.py install for moztest 01:17:44 INFO - Running setup.py install for mozversion 01:17:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:17:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:17:44 INFO - Cleaning up... 01:17:44 INFO - Return code: 0 01:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:44 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 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:44 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 01:17:44 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 01:17:44 INFO - Using env: {'DISPLAY': ':0', 01:17:44 INFO - 'HOME': '/home/cltbld', 01:17:44 INFO - 'LANG': 'en_US.UTF-8', 01:17:44 INFO - 'LANGUAGE': 'en_US:en', 01:17:44 INFO - 'LOGNAME': 'cltbld', 01:17:44 INFO - 'MAIL': '/var/mail/cltbld', 01:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:44 INFO - 'MOZ_NO_REMOTE': '1', 01:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:44 INFO - 'NO_EM_RESTART': '1', 01:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:44 INFO - 'PWD': '/builds/slave/test', 01:17:44 INFO - 'SHELL': '/bin/bash', 01:17:44 INFO - 'SHLVL': '1', 01:17:44 INFO - 'TERM': 'linux', 01:17:44 INFO - 'TMOUT': '86400', 01:17:44 INFO - 'USER': 'cltbld', 01:17:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:44 INFO - '_': '/tools/buildbot/bin/python'} 01:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:45 INFO - Running setup.py (path:/tmp/pip-yYlQrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:45 INFO - Running setup.py (path:/tmp/pip-9LR69m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:45 INFO - Running setup.py (path:/tmp/pip-7GIAEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:45 INFO - Running setup.py (path:/tmp/pip-e30TRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:45 INFO - Running setup.py (path:/tmp/pip-FM7e6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:45 INFO - Running setup.py (path:/tmp/pip-HVw571-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:45 INFO - Running setup.py (path:/tmp/pip-xJbuNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:45 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)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:45 INFO - Running setup.py (path:/tmp/pip-YTIFne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:45 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)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:45 INFO - Running setup.py (path:/tmp/pip-TKQJum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:45 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)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:45 INFO - Running setup.py (path:/tmp/pip-74ht9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:45 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)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:45 INFO - Running setup.py (path:/tmp/pip-XXk_vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:45 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)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:45 INFO - Running setup.py (path:/tmp/pip-RByUaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:46 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)) 01:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:46 INFO - Running setup.py (path:/tmp/pip-eLe7iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:46 INFO - Running setup.py (path:/tmp/pip-lfCQ01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:46 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)) 01:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:46 INFO - Running setup.py (path:/tmp/pip-R6wumL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:46 INFO - Running setup.py (path:/tmp/pip-ta1JI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:46 INFO - Running setup.py (path:/tmp/pip-EyOPJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:48 INFO - Downloading blessings-1.6.tar.gz 01:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:17:48 INFO - Installing collected packages: blessings 01:17:48 INFO - Running setup.py install for blessings 01:17:48 INFO - Successfully installed blessings 01:17:48 INFO - Cleaning up... 01:17:48 INFO - Return code: 0 01:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:48 INFO - Reading from file tmpfile_stdout 01:17:48 INFO - Current package versions: 01:17:48 INFO - argparse == 1.2.1 01:17:48 INFO - blessings == 1.6 01:17:48 INFO - blobuploader == 1.2.4 01:17:48 INFO - docopt == 0.6.1 01:17:48 INFO - manifestparser == 1.1 01:17:48 INFO - mozInstall == 1.12 01:17:48 INFO - mozcrash == 0.17 01:17:48 INFO - mozdebug == 0.1 01:17:48 INFO - mozdevice == 0.48 01:17:48 INFO - mozfile == 1.2 01:17:48 INFO - mozhttpd == 0.7 01:17:48 INFO - mozinfo == 0.9 01:17:48 INFO - mozleak == 0.1 01:17:48 INFO - mozlog == 3.2 01:17:48 INFO - moznetwork == 0.27 01:17:48 INFO - mozprocess == 0.22 01:17:48 INFO - mozprofile == 0.28 01:17:48 INFO - mozrunner == 6.11 01:17:48 INFO - mozscreenshot == 0.1 01:17:48 INFO - mozsystemmonitor == 0.3 01:17:48 INFO - moztest == 0.7 01:17:48 INFO - mozversion == 1.4 01:17:48 INFO - psutil == 3.1.1 01:17:48 INFO - requests == 1.2.3 01:17:48 INFO - wsgiref == 0.1.2 01:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 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 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:48 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 01:17:48 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 01:17:48 INFO - Using env: {'DISPLAY': ':0', 01:17:48 INFO - 'HOME': '/home/cltbld', 01:17:48 INFO - 'LANG': 'en_US.UTF-8', 01:17:48 INFO - 'LANGUAGE': 'en_US:en', 01:17:48 INFO - 'LOGNAME': 'cltbld', 01:17:48 INFO - 'MAIL': '/var/mail/cltbld', 01:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:48 INFO - 'MOZ_NO_REMOTE': '1', 01:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:48 INFO - 'NO_EM_RESTART': '1', 01:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:48 INFO - 'PWD': '/builds/slave/test', 01:17:48 INFO - 'SHELL': '/bin/bash', 01:17:48 INFO - 'SHLVL': '1', 01:17:48 INFO - 'TERM': 'linux', 01:17:48 INFO - 'TMOUT': '86400', 01:17:48 INFO - 'USER': 'cltbld', 01:17:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:48 INFO - '_': '/tools/buildbot/bin/python'} 01:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 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)) 01:17:48 INFO - Cleaning up... 01:17:48 INFO - Return code: 0 01:17:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:17:48 INFO - Using env: {'DISPLAY': ':0', 01:17:48 INFO - 'HOME': '/home/cltbld', 01:17:48 INFO - 'LANG': 'en_US.UTF-8', 01:17:48 INFO - 'LANGUAGE': 'en_US:en', 01:17:48 INFO - 'LOGNAME': 'cltbld', 01:17:48 INFO - 'MAIL': '/var/mail/cltbld', 01:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:48 INFO - 'MOZ_NO_REMOTE': '1', 01:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:48 INFO - 'NO_EM_RESTART': '1', 01:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:48 INFO - 'PWD': '/builds/slave/test', 01:17:48 INFO - 'SHELL': '/bin/bash', 01:17:48 INFO - 'SHLVL': '1', 01:17:48 INFO - 'TERM': 'linux', 01:17:48 INFO - 'TMOUT': '86400', 01:17:48 INFO - 'USER': 'cltbld', 01:17:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:48 INFO - '_': '/tools/buildbot/bin/python'} 01:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:49 INFO - Downloading/unpacking jsonschema 01:17:49 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 01:17:49 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 01:17:49 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 01:17:49 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 01:17:49 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 01:17:49 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 01:17:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:17:51 INFO - Downloading/unpacking functools32 (from jsonschema) 01:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:51 INFO - Downloading functools32-3.2.3-2.tar.gz 01:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:17:51 INFO - warning: no files found matching '*.txt' 01:17:51 INFO - no previously-included directories found matching 'build' 01:17:51 INFO - no previously-included directories found matching 'dist' 01:17:51 INFO - no previously-included directories found matching '.git*' 01:17:51 INFO - Installing collected packages: jsonschema, functools32 01:17:51 INFO - Running setup.py install for functools32 01:17:51 INFO - warning: no files found matching '*.txt' 01:17:51 INFO - no previously-included directories found matching 'build' 01:17:51 INFO - no previously-included directories found matching 'dist' 01:17:51 INFO - no previously-included directories found matching '.git*' 01:17:51 INFO - Successfully installed jsonschema functools32 01:17:51 INFO - Cleaning up... 01:17:51 INFO - Return code: 0 01:17:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:51 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 0x7ff067543f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', '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 01:17:51 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 01:17:51 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 01:17:51 INFO - Using env: {'DISPLAY': ':0', 01:17:51 INFO - 'HOME': '/home/cltbld', 01:17:51 INFO - 'LANG': 'en_US.UTF-8', 01:17:51 INFO - 'LANGUAGE': 'en_US:en', 01:17:51 INFO - 'LOGNAME': 'cltbld', 01:17:51 INFO - 'MAIL': '/var/mail/cltbld', 01:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:51 INFO - 'MOZ_NO_REMOTE': '1', 01:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:51 INFO - 'NO_EM_RESTART': '1', 01:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:51 INFO - 'PWD': '/builds/slave/test', 01:17:51 INFO - 'SHELL': '/bin/bash', 01:17:51 INFO - 'SHLVL': '1', 01:17:51 INFO - 'TERM': 'linux', 01:17:51 INFO - 'TMOUT': '86400', 01:17:51 INFO - 'USER': 'cltbld', 01:17:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:51 INFO - '_': '/tools/buildbot/bin/python'} 01:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:51 INFO - Downloading/unpacking flake8 01:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:17:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:17:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:17:54 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 01:17:54 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 01:17:54 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 01:17:54 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 01:17:54 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 01:17:54 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 01:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:17:54 INFO - no previously-included directories found matching 'docs/_build' 01:17:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:17:54 INFO - Running setup.py install for pep8 01:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:17:54 INFO - no previously-included directories found matching 'docs/_build' 01:17:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:17:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:17:54 INFO - Cleaning up... 01:17:54 INFO - Return code: 0 01:17:54 INFO - Running post-action listener: _resource_record_post_action 01:17:54 INFO - Running post-action listener: _start_resource_monitoring 01:17:54 INFO - Starting resource monitoring. 01:17:54 INFO - ##### 01:17:54 INFO - ##### Finished create-virtualenv step (success) 01:17:54 INFO - ##### 01:17:54 INFO - ##### 01:17:54 INFO - ##### Running install step. 01:17:54 INFO - ##### 01:17:54 INFO - Running pre-action listener: _resource_record_pre_action 01:17:54 INFO - Running main action method: install 01:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:54 INFO - Reading from file tmpfile_stdout 01:17:54 INFO - Detecting whether we're running mozinstall >=1.0... 01:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:17:54 INFO - Reading from file tmpfile_stdout 01:17:54 INFO - Output received: 01:17:54 INFO - Usage: mozinstall [options] installer 01:17:54 INFO - Options: 01:17:54 INFO - -h, --help show this help message and exit 01:17:54 INFO - -d DEST, --destination=DEST 01:17:54 INFO - Directory to install application into. [default: 01:17:54 INFO - "/builds/slave/test"] 01:17:54 INFO - --app=APP Application being installed. [default: firefox] 01:17:54 INFO - mkdir: /builds/slave/test/build/application 01:17:54 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'] 01:17:54 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 01:18:12 INFO - Reading from file tmpfile_stdout 01:18:12 INFO - Output received: 01:18:12 INFO - /builds/slave/test/build/application/firefox/firefox 01:18:12 INFO - Running post-action listener: _resource_record_post_action 01:18:12 INFO - ##### 01:18:12 INFO - ##### Finished install step (success) 01:18:12 INFO - ##### 01:18:12 INFO - ##### 01:18:12 INFO - ##### Running run-tests step. 01:18:12 INFO - ##### 01:18:12 INFO - Running pre-action listener: _resource_record_pre_action 01:18:12 INFO - Running main action method: run_tests 01:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:18:12 INFO - Python 2.7.3 01:18:12 INFO - Return code: 0 01:18:12 INFO - grabbing minidump binary from tooltool 01:18: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')]} 01:18:12 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 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:18:12 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 01:18:12 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 01:18:12 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 01:18:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:18:12 INFO - Return code: 0 01:18:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:18:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:18:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:18:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:18:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:18:13 INFO - Return code: 0 01:18:13 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/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 01:18:13 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/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 01:18:13 INFO - Using env: {'DISPLAY': ':0', 01:18:13 INFO - 'HOME': '/home/cltbld', 01:18:13 INFO - 'LANG': 'en_US.UTF-8', 01:18:13 INFO - 'LANGUAGE': 'en_US:en', 01:18:13 INFO - 'LOGNAME': 'cltbld', 01:18:13 INFO - 'MAIL': '/var/mail/cltbld', 01:18:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:18:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:13 INFO - 'MOZ_NO_REMOTE': '1', 01:18:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:13 INFO - 'NO_EM_RESTART': '1', 01:18:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:13 INFO - 'PWD': '/builds/slave/test', 01:18:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:18:13 INFO - 'SHELL': '/bin/bash', 01:18:13 INFO - 'SHLVL': '1', 01:18:13 INFO - 'TERM': 'linux', 01:18:13 INFO - 'TMOUT': '86400', 01:18:13 INFO - 'USER': 'cltbld', 01:18:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550', 01:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:13 INFO - '_': '/tools/buildbot/bin/python'} 01:18:13 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/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 01:18:14 INFO - mozversion application_buildid: 20160530220813 01:18:14 INFO - mozversion application_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 01:18:14 INFO - mozversion application_display_name: Nightly 01:18:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:18:14 INFO - mozversion application_name: Firefox 01:18:14 INFO - mozversion application_remotingname: firefox 01:18:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:18:14 INFO - mozversion application_vendor: Mozilla 01:18:14 INFO - mozversion application_version: 49.0a1 01:18:14 INFO - mozversion platform_buildid: 20160530220813 01:18:14 INFO - mozversion platform_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 01:18:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:18:14 INFO - mozversion platform_version: 49.0a1 01:18:14 INFO - using testdate: 1464682694 01:18:14 INFO - actual date: 1464682694 01:18:14 INFO - starting webserver on 'localhost:50563' 01:18:14 INFO - SUITE-START | Running 2 tests 01:18:14 INFO - TEST-START | dromaeo_css 01:18:14 INFO - operating with platform_type : linux_ 01:18:14 INFO - Initialising browser for dromaeo_css test... 01:18:14 INFO - TEST-INFO | started process 10640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2E3pSf/profile http://localhost:50563/getInfo.html) 01:18:18 INFO - PROCESS | 10640 | __metrics Screen width/height:1600/1200 01:18:18 INFO - PROCESS | 10640 | colorDepth:24 01:18:18 INFO - PROCESS | 10640 | Browser inner width/height: 1024/697 01:18:18 INFO - PROCESS | 10640 | __metrics 01:18:19 ERROR - PROCESS | 10640 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:18:20 INFO - TEST-INFO | 10640: exit 0 01:18:20 INFO - Browser initialized. 01:18:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:18:20 INFO - TEST-INFO | started process 10723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2E3pSf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:18:32 INFO - PROCESS | 10723 | RSS: Main: 156254208 01:18:32 INFO - PROCESS | 10723 | 01:19:23 INFO - PROCESS | 10723 | 1464682763624 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] 01:21:31 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50563/tests/dromaeo/cssquery-ext.html) 01:21:32 INFO - PROCESS | 10723 | RSS: Main: 247930880 01:21:32 INFO - PROCESS | 10723 | 01:24:34 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-ext.html (next: http://localhost:50563/tests/dromaeo/cssquery-jquery.html) 01:24:35 INFO - PROCESS | 10723 | RSS: Main: 249044992 01:24:35 INFO - PROCESS | 10723 | 01:27:37 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50563/tests/dromaeo/cssquery-mootools.html) 01:27:37 INFO - PROCESS | 10723 | RSS: Main: 251445248 01:27:37 INFO - PROCESS | 10723 | 01:30:39 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50563/tests/dromaeo/cssquery-prototype.html) 01:30:40 INFO - PROCESS | 10723 | RSS: Main: 244277248 01:30:40 INFO - PROCESS | 10723 | 01:33:43 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50563/tests/dromaeo/cssquery-yui.html) 01:33:43 INFO - PROCESS | 10723 | RSS: Main: 230354944 01:33:43 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | Cycle 1(1): loaded http://localhost:50563/tests/dromaeo/cssquery-yui.html (next: http://localhost:50563/tests/dromaeo/cssquery-dojo.html) 01:36:46 INFO - PROCESS | 10723 | RSS: Main: 323629056 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | __start_tp_report 01:36:46 INFO - PROCESS | 10723 | _x_x_mozilla_page_load 01:36:46 INFO - PROCESS | 10723 | _x_x_mozilla_page_load_details 01:36:46 INFO - PROCESS | 10723 | |i|pagename|runs| 01:36:46 INFO - PROCESS | 10723 | |0;dojo.html;3101.457244982128;3112.875484980601;3139.403513332466;3157.41587806256;3175.491921292592;5284.8150314739;5359.5444387227035;5372.113601255793;5415.83752487425;5493.5055844973895;5316.654417462872;5364;5437.157240627709;5440.537554307879;5468.6171967962255;4837.008413275279;4878.463369029404;4893.41279046515;4901.411830580318;5108.770105345268;5006.5744411725045;5014.373203349582;5040.395152581696;5060.987802439508;5065.6200784941275;4858.02839432115;4894.755262236892;4912.508749125094;4955.578775804061;4964.602831773467;4899.363082799249;4907.533784290486;4912.533309335608;4928.926066109011;4953.653244272902;4916.041371932474;4947.653664243504;4954.033963377143;4964.702117872939;4967.975160124212;5164.974175129138;5331.413544510101;5391.406945236021;5404.243405923174;5405.594580406446;5855.268091488564;5911.172435858984;5917.792877249276;5918.674472903988;5921.023031199847;5889.8822023559715;5947.613405128696;5957.314908785502;5957.434043765836;5962.761489540413;5321.893562128775;5437.265969094161;5482.122860342366;5486.945130548684;5543.861403464945;6025.0359942409;6031.4270144336215;6032.095185722177;6039.4262545058145;6040.124181993587;5543.916841247385;5806.738696758656;5807.970960145257;5810.070388737781;5814;5720.313562372458;5761.9135712964335;5768.105943578752;5780.768769249267;5802.100674395391;5766.596338256366;5772.076467765138;5774.740136693859;5777.711114444261;5778.27771528559;5580.553555715533;5704.657720536781;5727.513161381329;5782.739776710058;5789.8552536186935;4396.538363471789;4423.20382331177;4427.667924905645;4465.799039043251;4467.664925130628;3926.2932672118723;3938.468306778548;3948.7038472114705;3962.3462128748433;3982.7809470478824;5353.250544923714;5384.596155288369;5407.540359069444;5526.088195447706;5533.03171944908;5746.367899531048;5762.596618236683;5789.739461724233;5796.739146738407;5847.853803654943;5450.727463626882;5459.262999495097;5459.781608735606;5474.698891561003;5477.28795256622;4858.46556878743;4952.727599982036;4955.801767929314;4973.676711013773;5000.174971129795;6020.488258498077;6024.945634513942;6028.909566356509;6030.095485677096;6080.0879868019265;5826.009578371687;5833.854153646023;5837.737301821513;5858.619189752652;5860.09168578871;5891.528677705687;5913.053911374332;5931.288245410578;5950.285965684146;6027.78902738402;5646.040173170489;5688.431156884279;5696.658200507983;5700.800471983461;5714.914276285942;5804.506616937608;5814.186013958134;5819.5344372450945;5824.970875145597;5826.096954971986;5456.09974354243;5662.405447427961;5694.373618902;5715.542756579547;5736.913946290892;5688.829335119953;5690.630109042899;5693.715314234189;5699.145128230799;5702.059160238514;5507.779688812403;5607.663540187602;5613.775448981995;5614.21401003868;5618;5729.28383952006;5762.7694892203845;5773.336066352424;5849.415058494116;5853.239078919713;5675.489205971482;5676.914846277392;5678.176664383559;5699.2590963174525;5724.427557244242 01:36:46 INFO - PROCESS | 10723 | |1;ext.html;631.6052467207994;643.154252158412;651.3974573519494;651.8402991267137;658.3383699382117;31509.369812603734;34366.48450273248;34384.31231375374;34398.312033759306;34470.793522226755;34981.65018349816;43807.561924380745;44617.55382446183;44731;48168.51831481684;8656.523891185981;8815.074417186199;8822.823543529126;8823.64705411786;8839.513826739527;8551.273141782956;8622.698205562807;8684.782880427976;8688.956555217246;8694.17405346491;8697.217250447458;8713.651453941835;8743.344249181306;8745.606447709837;8752.168543988342;8663.39356245063;8707;8721.912780872173;8725.563721813884;8725.912740872605;8698.999615044288;8775.429597076234;8780.297576193952;8789.165029322205;8796.736097917073;41055;41467;41479.37780933289;41501.377479337534;41506.54727084568;3438.1404648837793;3608.747387682863;4145;4194.601512856304;4284.742915425053;31368.215794605316;31750.364992700015;31774.364512709617;31903.84048079768;33678.6632133678;4219.767912764797;4408.625266852321;4420.20436321462;4482.663800214997;4490.438695163105;336183;337232;337543;338003;338081;56200.71899640557;56647.716761416756;56723;56900.71549642225;57002.144967825516;59360.40639593635;59374.40625593689;59478.40521594815;59479.40520594825;59531;16110.75833862493;16276.10481423533;16313.918430407772;16321.265543050591;16323.510294691177;13070.215787052808;13132.737345253041;13134.474621015244;13146.342682865818;13149.868501315055;14195.432182712782;15811.683766324839;15832.525024249291;15887.205639717968;15888.682226355408;5207.843764687065;5790.536757059425;5930.822075337746;6101.389861013863;6120.7551697931585;978.8287049766262;1012.9392583341936;1032.7986042721748;1115.1524841120806;1148.1388958281289;31581.210469738442;32231;32284.35431291361;32498.35003299921;32921;1102.9779404412027;1143.2168964259508;1150.327058670687;1157.7337212441187;1166.2943918928927;16777.664446710998;17135.22891469887;17152.742708859376;17378.39175628847;17445.651086978443;514110;515360;516508;518628;519355;56856.43143568594;56928.43071569314;56943.14585281224;56961.715191424606;57012.149392530206;1290.7934730443085;1363.8840698540735;1386.0644065255913;1416.723738870931;1428.5071650280636;31606.683933160373;32474;32511.18722031968;32668.346633067682;32963.67036329702;48633.082015079206;48644;49063.75468122637;49130.50869491259;49186;385991;386269;386577;387007;388227;24135.39661508406;26655;26985.73014269832;27437.31406714848;28243.435131296847;44919.55080449284;45261.54738452705;45409.31886021646;46011;46097.769511152226;36847.44728829123;39220.41169382518;39387.80306098566;39535.40696889492;40757.1848563033;39002;39578;39751;40011.59988400079;40089;38594.42108368433;39206.215875682894;39752.403713943735;39764;39767.80116099401;32332.67667323391;35411.33047635542;35781.28437431289;35836.10409739777;36047;26993.190204293904;27405.58891616667;27631;27638.86180569084;27860 01:36:46 INFO - PROCESS | 10723 | |2;jquery.html;379.3134426687695;390.68940192546927;394.6527056190552;397.8070635741665;417.6032768869573;18172.36396726115;19193;19641.312554060594;19654.21383144674;19699.212031518757;17977;18493.53766155847;18624.44126676202;18767.718484222747;19012.809871901278;5671.177679236519;5794.39158888317;5798.681072541009;5842.912356314638;5845.240118784552;5673.461021202979;5763.423657634224;5771.451712087345;5773.076307790754;5793.565482588801;5584.301962254718;5688.146777983315;5727.971360143193;5747.1666608341975;5758.539316854642;5640.153976903456;5650.434956504358;5706.087026075808;5737.9713101434645;5742.339630942432;5062.645614806928;5413.621046526705;5415.593830462731;5456.699881506515;5476.726163691839;13457.798133028013;13544.255065971367;13750.243736594482;13764.862351376458;13850.238236896967;2196.560687862418;2278.236790675126;2342.5900467418305;2371.4664200554907;2830.5754136879427;9521.962667939579;9767.462789546573;9900.417379336504;9991.450470224136;10245.74385640365;1645.539249010279;1756.6398888228011;1879.2483006797254;1899.4871384726046;1936.912838922252;80822.59588702078;85312;85313.57343213307;85703.57148214281;85875.57062214712;10237.464380343008;10494.527746251284;10555.525001374957;10614.734631634117;11319.434028298552;14324.14055156694;14370;14435.927820361041;14441.566752997427;14453.78319325211;7927.5243485391065;7948.324392426708;8044.597770111588;8210.384221183434;8254.504729716236;7604.239576042462;7742.729004484816;7768.533887966627;7888.7633370998965;7914.683412663429;4456.710313829591;4460.843870464518;4467.989404767867;4469.843555475542;4521.547845215452;1925.4801203674929;1926.1428664244556;1940.3693799515213;1970.8029197080177;1972.7139564763315;876.8640860666607;957.0955447102422;1017.0084167936203;1018.3787889387468;1044.5351818440872;16784.916075419787;17887.463376098738;18103.72844407335;18236.63526729458;19955.20179192845;972.5817898303798;992.7766252593109;1006.2402885821305;1020.2552136940076;1028.290479569095;10484.26610137283;10492.160627149962;10632.893671063344;10698.304610200312;10708.357498550113;480253;490681;499833;502189;502215;60767.08849367263;69817;84944;85693.57153214194;92359;1002.644061358222;1006.7483129217695;1031.7111208861681;1042.1923009667416;1045.5504133222787;12566.711307441845;16262.268197931358;16627.584310392336;16850.74723879167;16986.575335616708;41375.58624413717;41580.58419415767;42842.5715742851;42846.785766072215;43099.35350969675;54394;55515.72242138763;55703.442965569826;56424.71787641035;57435.71282143563;8194.959025204837;8205.220504052106;8362.87455688153;8524.786880328042;8716.084811094745;11874.584389546324;12757.170783899017;12840;12854.935725321313;12875.227486350848;5935.614185077956;8248.54632995191;10738.516766745359;10810.13518918469;10877.67366978992;10907.509162087883;10982.341059536133;11142.997130258316;11287.830682539605;11449.026832719312;10790.352578845295;10919.126469882549;10935.179861510578;10937.781244375226;11044.447777611247;8038.557879316693;8153.959230203811;8271.751847444586;8407.369447291356;8643.438176518506;9975.20198384142;10749.301295415773;10830.566777328819;10844.620438284623;10936.234463587472 01:36:46 INFO - PROCESS | 10723 | |3;mootools.html;1400.27185863351;1516.9241537923106;1562.914039727815;1693.8814283000188;1858.6282743451313;8640.179182977616;8961.417507861985;8971.91028089719;9261;9277.628894844214;8999.640014399416;9208.953955230214;9209.355345125843;9211.309151813608;9214.308926830498;2338.240071976606;2362.185046159081;2364.243442098529;2365.503244318695;2365.9171928982405;2242.8878556072214;2275.4311422144465;2278.897449614763;2287.5996700577416;2289.9885500572473;2348.189874493297;2351.623740201568;2366.893489792955;2380.7262164851004;2384.0940442631777;2222.1666874921902;2252.121672547716;2261.4685548895995;2280.099360752502;2341.4731685370825;2300.332903457995;2301.2290882554366;2303.9632165525413;2307.2501437033034;2320.071971211512;8729.60716767747;8917.687880924137;8961.462312261285;9098.909010909872;9098.909010909872;5374.758135883894;5518.724063796794;5519.530839878616;5520.006398848206;5523.088690366085;3381.898543043713;3459.8616055358007;3489.4068008438626;3510.912227194315;3511.051366491596;1162.1806626328419;1181.5746331320804;1190.4523918997186;1193.8328633991248;2116.2698868890207;12756.2984035878;12828.102032857703;12853.421596028202;12859.678508037281;12870.16343937641;4470.173017991682;4551.135284295973;4615.930761038587;4616.792244349012;4690;9972.850407243897;9975.301728878909;10008.149307308815;10019.448930308903;10032.097111260022;5337.2794672719465;5346.518813306821;5347.438518955531;5353.2237825515085;5355.410904800468;4134.3178375567695;4224.324108142682;4339.500957389878;4913.459519452857;4949.381327334083;3739.607341229186;3758.229562939591;3785.3186426443503;3823.5029446172375;3884.533855937306;1066.8826429092794;1078.078243102152;1079.0504356166523;1080.9297395669257;1084.1056128693701;843.5107637570195;946.9100435458621;1010.6109147977934;1011.9139873110721;1052.7894421115807;6198.81403557894;6247;6308.148399966038;6433.710483028275;6439.098526206335;905.76902889764;1008;1015.081351377005;1021.1575450253571;1049.532957833772;4343.82624695015;4371.934420983688;4412.646988240997;4437.267850804646;4451.1765323415275;11388.145889058354;11795.174337796443;11863.70340741471;11874;11876.762464750656;10851.186161037953;11211.439428028565;11629.88370116288;11742.823857642143;11750.764984700429;8401.285890699237;8466.068732439428;8512.978442586806;8550.187732165434;8573.27127194183;6126.785562505291;6425.614463132227;6443.838904027437;6482.57863238888;6504.869902602016;10362.963703629577;10416.375017498975;10639.468026598794;10680.83978740335;10681.985211404904;10638.787224255626;10770.407627580245;10810.18923580719;10816.621418250323;10866;7425.14610819741;7838.725644602411;8008.919910800817;8039.075506316614;8312.459690120122;8929.241014513838;8946.329025322997;8967.820643587222;9003.594838232426;9041.095890410907;8115.269625733712;8140.552269624991;8180.877286840821;8229.506229626242;8295.875561866698;8005;8040.758777236692;8043;8079.394045446497;8271.296939760188;7282.854342913218;7384.224656410999;7386.15059268191;7388.926110739038;7392.55644661322;5116.948830511647;5278;5387.622866399314;5434.483724046209;5542.528885044655;5336.599755018467;5399.5950303726595;5450.127979523258;5455.809046683347;5526.640768350045 01:36:46 INFO - PROCESS | 10723 | |4;prototype.html;328.71730311931736;329.63410614218213;333.4614597425158;337.9645137260588;338.0450228105602;5374.5700343972485;5398.676079435237;5402.6758394496355;5421.1326187809955;5446;5261.815836445725;5268.841934741954;5344.171653393731;5358.866028349294;5383.865403364918;3973.8410463581495;4076.7757773322455;4209.536950935395;4212.55768144345;4234.322508398657;4147.460830092084;4164.500259968793;4180.24755544002;4199.7690127043;4199.992001919532;3973.3046716824583;4159.688023398242;4161.292580261363;4162.396452514398;4176.290030694774;4057.6204090609335;4061.776602286873;4085.346344584867;4127.545969943304;4135.855245066438;3636.4908912752235;3663.8900832975055;3667.8899633010788;3673.045008297835;3690.1881586051295;5068.873278168038;5069.974650126763;5079.034983353151;5085;5103.336566246364;4582.725036497787;4736.407949006374;4772.403449568804;4782.784774685148;4804.783784729696;5465.426130256305;5479.342478902558;5484.862878428032;5508.614396992212;5522.420145884705;3859.5754467008605;3998.5001874765653;4026.4362989181536;4033.8184781684895;4056.391541268804;5757.251557297524;5761.876434095353;5764.135379692996;5780.8843823123725;5781.335146458127;4032.6370626643156;4039.8688367257214;4042.757434553936;4061.147159096564;4063.4152680454645;3915.1778126593163;4102.671786257092;4107.028626259412;4108.424820525129;4147.771872546979;4664.976675116671;4691.741954192552;4699.647526435531;4700.435947686231;4706.599939005155;5501.669899806025;5527.309086364205;5554.305711786027;5559.527440167551;5580.86047848807;1360.768669326217;1402.8737413632823;1414.3564678071452;1422.5021242565226;1431.255747011569;904.0733248420422;905.7101727447285;909.377076702461;922.7923717163585;960.1071003966379;5308.150695888639;5338.572914166935;5357;5366.973165134149;5367;5664;5673.319201695823;5682.261306030189;5695.7152142392715;5708.40061793514;5253.658512196772;5258.605604579672;5337.706426146521;5355.135002773497;5378.91931621026;3020.1845501714415;3047.527633216855;3052.0996306089755;3052.4047810676707;3056.43455960648;5677.37548869624;5906.616069955439;5915.497182739516;5921.683857040071;5939.46544810969;5769.798057067983;5784.88430231393;5789.739461724233;5803.158542011384;5808.186853840466;5787.5080618147085;5827.504662103769;5830.038043722739;5840.773437578071;5900.173975643499;5502.477264659851;5716.28546431696;5726.484616384545;5885.47030767233;5886.852828679317;5763.625364351304;5792.189093526994;5809.651420914759;5816.883662326814;5817.312979235974;5720.6853623049465;6067.332593414632;6110.816675499742;6111.388861114031;6135.202423684892;4005.339119045325;4012.518497780285;4025.033991841878;4034.5360283566592;4038.293298672779;5785.190073389813;5807.070868660994;5821.446962538552;5848;5862.267216597926;5437.4562543745305;5670.3272534601565;5695.601307908407;5702.714864256854;5736.852629474205;5554.722413844919;5579.8047068354035;5641.210230567642;5653.406392328746;5658.688772117573;5357.303550538405;5402.51377376038;5531.391546929915;5572.498475137257;5630.4369563043365;5611.158326251095;5616.522595579421;5624.85937851557;5661.547076233974;5677.829665110054;5518.917216241679;5546.306711661043;5549.529374715784;5552.444755524577;5556.333240011225 01:36:46 INFO - PROCESS | 10723 | |5;yui.html;791.9920800791992;834.987475187872;838.0488145954348;844.7803571071521;844.8394804987053;16486.50540483786;17065.402710905106;17070.231839567234;17595.12024398778;17728.37950671727;15652.686946261096;15702.214889255549;15759.054456732576;15794.605134871605;15820;678.5555461172939;796.1083586383245;798.4530596541359;800.9159038300982;801.5431204213601;792.6433105102698;792.9801754956114;797.5693125712138;813.4265342933218;814.6130587970696;838.2413915406567;840.8234270803108;841.9957900210521;843.8017065989487;844.1136806353335;710.2684235237714;714.1679942866555;841.7853447370942;842.0653075086649;842.4860834890711;592.3277080513604;592.8873514032321;607.6536374266669;608.084832327349;609.05596325695;14878.10731356122;14924.62688432787;14925.179115148663;14932;14945.17801520916;12384.318862462562;12824.935875320656;12950.352482375843;13133.408996595175;13482.932585337108;11022.228444008922;11542.935544486476;11575.594854180063;11771.352575608338;11924.642260732191;3768.8869333920024;3772.2266935278203;3818.3317919364276;3876.8643097491454;3948.4077388391684;59571.40428595702;59683.70158149225;61492.69253653703;61601.33237216942;61915;9907.306488545877;10513;10537.420441875616;10664.146868250522;10999.34003959765;19059.714104288447;19685.704714429296;20031.09860056301;20036.69944950827;20044.198232070554;8497.915020849712;8543.829123417621;8544.786380340416;8599.398042137116;8652.913470865336;4726.574608285271;4822.590079843182;4863.392075990501;4867.123917694778;5019.573336266385;3596.892093237207;3672.7245456590863;3673.1368128489785;3678.834452449646;3684.3552378333684;687.1273482676972;696.613379574331;702.9543079699803;703.4583370804452;703.63762662229;602.5330368964001;603.1043899808781;702.3854127638316;707.2220557386936;768.9692412303557;9492.477913714674;10031.347962382568;10093.192544596415;10099.242556808269;10136.341137826017;594.4501336263938;644.490852226745;652.3704625036768;670.4401824476616;771.8996530451005;4394.648428125743;4529.9547004530195;4538.478075021349;4546.88632784183;4598.793054312564;67889.32110678928;68639;68721.3127868715;70646.293537065;71169.2883071173;61973.22311079159;62054.932858728076;62080;62630.68684656548;63083;57108.42891571197;57114.7144264276;57192.56670616285;57584.42415575791;57885.13172302419;8631.180037896389;8718;8809.735707928772;8864.512451815212;9031;36525;37527.43708844315;37706;38110;38256.426153607164;50139.74930125326;51709;51852;51912.221316679526;52127.47872521378;11471;11607.361595112012;11838.763224735629;11921.344326061802;12034.157608967289;12692.048096392622;13020.218786872818;13032.869671303166;13374.264415457243;13479.528216512375;12234.300833391082;12555.121141520005;12651.746965060831;12713.300768457824;12787.104902656725;12531.93734031324;12662.430190641258;12677.492900283885;12691.619251422471;12778.361081946052;12434.689132771391;13293.281980361127;13569.660758481117;13943.930280348533;13961.441542338192;11054.944725276644;11233.71915702114;11501.137414694098;11521.88478115208;11591.304521728724;11094.44527773592;11877.406129693309;12011.339376334385;12055.15613907018;12279.324637145042 01:36:46 INFO - PROCESS | 10723 | __end_tp_report 01:36:46 INFO - PROCESS | 10723 | __start_cc_report 01:36:46 INFO - PROCESS | 10723 | _x_x_mozilla_cycle_collect,816 01:36:46 INFO - PROCESS | 10723 | __end_cc_report 01:36:46 INFO - PROCESS | 10723 | __startTimestamp1464683806493__endTimestamp 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | ------- Summary: start ------- 01:36:46 INFO - PROCESS | 10723 | Number of tests: 6 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#0] dojo.html Cycles:165 Average:5398.52 Median:5618.00 stddev:621.16 (11.1%) stddev-sans-first:596.35 01:36:46 INFO - PROCESS | 10723 | Values: 3101.5 3112.9 3139.4 3157.4 3175.5 5284.8 5359.5 5372.1 5415.8 5493.5 5316.7 5364.0 5437.2 5440.5 5468.6 4837.0 4878.5 4893.4 4901.4 5108.8 5006.6 5014.4 5040.4 5061.0 5065.6 4858.0 4894.8 4912.5 4955.6 4964.6 4899.4 4907.5 4912.5 4928.9 4953.7 4916.0 4947.7 4954.0 4964.7 4968.0 5165.0 5331.4 5391.4 5404.2 5405.6 5855.3 5911.2 5917.8 5918.7 5921.0 5889.9 5947.6 5957.3 5957.4 5962.8 5321.9 5437.3 5482.1 5486.9 5543.9 6025.0 6031.4 6032.1 6039.4 6040.1 5543.9 5806.7 5808.0 5810.1 5814.0 5720.3 5761.9 5768.1 5780.8 5802.1 5766.6 5772.1 5774.7 5777.7 5778.3 5580.6 5704.7 5727.5 5782.7 5789.9 4396.5 4423.2 4427.7 4465.8 4467.7 3926.3 3938.5 3948.7 3962.3 3982.8 5353.3 5384.6 5407.5 5526.1 5533.0 5746.4 5762.6 5789.7 5796.7 5847.9 5450.7 5459.3 5459.8 5474.7 5477.3 4858.5 4952.7 4955.8 4973.7 5000.2 6020.5 6024.9 6028.9 6030.1 6080.1 5826.0 5833.9 5837.7 5858.6 5860.1 5891.5 5913.1 5931.3 5950.3 6027.8 5646.0 5688.4 5696.7 5700.8 5714.9 5804.5 5814.2 5819.5 5825.0 5826.1 5456.1 5662.4 5694.4 5715.5 5736.9 5688.8 5690.6 5693.7 5699.1 5702.1 5507.8 5607.7 5613.8 5614.2 5618.0 5729.3 5762.8 5773.3 5849.4 5853.2 5675.5 5676.9 5678.2 5699.3 5724.4 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#1] ext.html Cycles:180 Average:57099.14 Median:39751.70 stddev:111404.15 (280.3%) stddev-sans-first:111635.99 01:36:46 INFO - PROCESS | 10723 | Values: 631.6 643.2 651.4 651.8 658.3 31509.4 34366.5 34384.3 34398.3 34470.8 34981.7 43807.6 44617.6 44731.0 48168.5 8656.5 8815.1 8822.8 8823.6 8839.5 8551.3 8622.7 8684.8 8689.0 8694.2 8697.2 8713.7 8743.3 8745.6 8752.2 8663.4 8707.0 8721.9 8725.6 8725.9 8699.0 8775.4 8780.3 8789.2 8796.7 41055.0 41467.0 41479.4 41501.4 41506.5 3438.1 3608.7 4145.0 4194.6 4284.7 31368.2 31750.4 31774.4 31903.8 33678.7 4219.8 4408.6 4420.2 4482.7 4490.4 336183.0 337232.0 337543.0 338003.0 338081.0 56200.7 56647.7 56723.0 56900.7 57002.1 59360.4 59374.4 59478.4 59479.4 59531.0 16110.8 16276.1 16313.9 16321.3 16323.5 13070.2 13132.7 13134.5 13146.3 13149.9 14195.4 15811.7 15832.5 15887.2 15888.7 5207.8 5790.5 5930.8 6101.4 6120.8 978.8 1012.9 1032.8 1115.2 1148.1 31581.2 32231.0 32284.4 32498.4 32921.0 1103.0 1143.2 1150.3 1157.7 1166.3 16777.7 17135.2 17152.7 17378.4 17445.7 514110.0 515360.0 516508.0 518628.0 519355.0 56856.4 56928.4 56943.1 56961.7 57012.1 1290.8 1363.9 1386.1 1416.7 1428.5 31606.7 32474.0 32511.2 32668.3 32963.7 48633.1 48644.0 49063.8 49130.5 49186.0 385991.0 386269.0 386577.0 387007.0 388227.0 24135.4 26655.0 26985.7 27437.3 28243.4 44919.6 45261.5 45409.3 46011.0 46097.8 36847.4 39220.4 39387.8 39535.4 40757.2 39002.0 39578.0 39751.0 40011.6 40089.0 38594.4 39206.2 39752.4 39764.0 39767.8 32332.7 35411.3 35781.3 35836.1 36047.0 26993.2 27405.6 27631.0 27638.9 27860.0 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#2] jquery.html Cycles:180 Average:28259.72 Median:392.67 stddev:81515.91 (20759.3%) stddev-sans-first:81717.70 01:36:46 INFO - PROCESS | 10723 | Values: 379.3 390.7 394.7 397.8 417.6 18172.4 19193.0 19641.3 19654.2 19699.2 17977.0 18493.5 18624.4 18767.7 19012.8 5671.2 5794.4 5798.7 5842.9 5845.2 5673.5 5763.4 5771.5 5773.1 5793.6 5584.3 5688.1 5728.0 5747.2 5758.5 5640.2 5650.4 5706.1 5738.0 5742.3 5062.6 5413.6 5415.6 5456.7 5476.7 13457.8 13544.3 13750.2 13764.9 13850.2 2196.6 2278.2 2342.6 2371.5 2830.6 9522.0 9767.5 9900.4 9991.5 10245.7 1645.5 1756.6 1879.2 1899.5 1936.9 80822.6 85312.0 85313.6 85703.6 85875.6 10237.5 10494.5 10555.5 10614.7 11319.4 14324.1 14370.0 14435.9 14441.6 14453.8 7927.5 7948.3 8044.6 8210.4 8254.5 7604.2 7742.7 7768.5 7888.8 7914.7 4456.7 4460.8 4468.0 4469.8 4521.5 1925.5 1926.1 1940.4 1970.8 1972.7 876.9 957.1 1017.0 1018.4 1044.5 16784.9 17887.5 18103.7 18236.6 19955.2 972.6 992.8 1006.2 1020.3 1028.3 10484.3 10492.2 10632.9 10698.3 10708.4 480253.0 490681.0 499833.0 502189.0 502215.0 60767.1 69817.0 84944.0 85693.6 92359.0 1002.6 1006.7 1031.7 1042.2 1045.6 12566.7 16262.3 16627.6 16850.7 16986.6 41375.6 41580.6 42842.6 42846.8 43099.4 54394.0 55515.7 55703.4 56424.7 57435.7 8195.0 8205.2 8362.9 8524.8 8716.1 11874.6 12757.2 12840.0 12854.9 12875.2 5935.6 8248.5 10738.5 10810.1 10877.7 10907.5 10982.3 11143.0 11287.8 11449.0 10790.4 10919.1 10935.2 10937.8 11044.4 8038.6 8154.0 8271.8 8407.4 8643.4 9975.2 10749.3 10830.6 10844.6 10936.2 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#3] mootools.html Cycles:180 Average:6008.24 Median:4424.96 stddev:3467.38 (78.4%) stddev-sans-first:3459.81 01:36:46 INFO - PROCESS | 10723 | Values: 1400.3 1516.9 1562.9 1693.9 1858.6 8640.2 8961.4 8971.9 9261.0 9277.6 8999.6 9209.0 9209.4 9211.3 9214.3 2338.2 2362.2 2364.2 2365.5 2365.9 2242.9 2275.4 2278.9 2287.6 2290.0 2348.2 2351.6 2366.9 2380.7 2384.1 2222.2 2252.1 2261.5 2280.1 2341.5 2300.3 2301.2 2304.0 2307.3 2320.1 8729.6 8917.7 8961.5 9098.9 9098.9 5374.8 5518.7 5519.5 5520.0 5523.1 3381.9 3459.9 3489.4 3510.9 3511.1 1162.2 1181.6 1190.5 1193.8 2116.3 12756.3 12828.1 12853.4 12859.7 12870.2 4470.2 4551.1 4615.9 4616.8 4690.0 9972.9 9975.3 10008.1 10019.4 10032.1 5337.3 5346.5 5347.4 5353.2 5355.4 4134.3 4224.3 4339.5 4913.5 4949.4 3739.6 3758.2 3785.3 3823.5 3884.5 1066.9 1078.1 1079.1 1080.9 1084.1 843.5 946.9 1010.6 1011.9 1052.8 6198.8 6247.0 6308.1 6433.7 6439.1 905.8 1008.0 1015.1 1021.2 1049.5 4343.8 4371.9 4412.6 4437.3 4451.2 11388.1 11795.2 11863.7 11874.0 11876.8 10851.2 11211.4 11629.9 11742.8 11750.8 8401.3 8466.1 8513.0 8550.2 8573.3 6126.8 6425.6 6443.8 6482.6 6504.9 10363.0 10416.4 10639.5 10680.8 10682.0 10638.8 10770.4 10810.2 10816.6 10866.0 7425.1 7838.7 8008.9 8039.1 8312.5 8929.2 8946.3 8967.8 9003.6 9041.1 8115.3 8140.6 8180.9 8229.5 8295.9 8005.0 8040.8 8043.0 8079.4 8271.3 7282.9 7384.2 7386.2 7388.9 7392.6 5116.9 5278.0 5387.6 5434.5 5542.5 5336.6 5399.6 5450.1 5455.8 5526.6 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#4] prototype.html Cycles:180 Average:4702.71 Median:5381.39 stddev:1394.66 (25.9%) stddev-sans-first:1359.39 01:36:46 INFO - PROCESS | 10723 | Values: 328.7 329.6 333.5 338.0 338.0 5374.6 5398.7 5402.7 5421.1 5446.0 5261.8 5268.8 5344.2 5358.9 5383.9 3973.8 4076.8 4209.5 4212.6 4234.3 4147.5 4164.5 4180.2 4199.8 4200.0 3973.3 4159.7 4161.3 4162.4 4176.3 4057.6 4061.8 4085.3 4127.5 4135.9 3636.5 3663.9 3667.9 3673.0 3690.2 5068.9 5070.0 5079.0 5085.0 5103.3 4582.7 4736.4 4772.4 4782.8 4804.8 5465.4 5479.3 5484.9 5508.6 5522.4 3859.6 3998.5 4026.4 4033.8 4056.4 5757.3 5761.9 5764.1 5780.9 5781.3 4032.6 4039.9 4042.8 4061.1 4063.4 3915.2 4102.7 4107.0 4108.4 4147.8 4665.0 4691.7 4699.6 4700.4 4706.6 5501.7 5527.3 5554.3 5559.5 5580.9 1360.8 1402.9 1414.4 1422.5 1431.3 904.1 905.7 909.4 922.8 960.1 5308.2 5338.6 5357.0 5367.0 5367.0 5664.0 5673.3 5682.3 5695.7 5708.4 5253.7 5258.6 5337.7 5355.1 5378.9 3020.2 3047.5 3052.1 3052.4 3056.4 5677.4 5906.6 5915.5 5921.7 5939.5 5769.8 5784.9 5789.7 5803.2 5808.2 5787.5 5827.5 5830.0 5840.8 5900.2 5502.5 5716.3 5726.5 5885.5 5886.9 5763.6 5792.2 5809.7 5816.9 5817.3 5720.7 6067.3 6110.8 6111.4 6135.2 4005.3 4012.5 4025.0 4034.5 4038.3 5785.2 5807.1 5821.4 5848.0 5862.3 5437.5 5670.3 5695.6 5702.7 5736.9 5554.7 5579.8 5641.2 5653.4 5658.7 5357.3 5402.5 5531.4 5572.5 5630.4 5611.2 5616.5 5624.9 5661.5 5677.8 5518.9 5546.3 5549.5 5552.4 5556.3 01:36:46 INFO - PROCESS | 10723 | 01:36:46 INFO - PROCESS | 10723 | [#5] yui.html Cycles:180 Average:16100.10 Median:4542.68 stddev:19366.19 (426.3%) stddev-sans-first:19386.40 01:36:46 INFO - PROCESS | 10723 | Values: 792.0 835.0 838.0 844.8 844.8 16486.5 17065.4 17070.2 17595.1 17728.4 15652.7 15702.2 15759.1 15794.6 15820.0 678.6 796.1 798.5 800.9 801.5 792.6 793.0 797.6 813.4 814.6 838.2 840.8 842.0 843.8 844.1 710.3 714.2 841.8 842.1 842.5 592.3 592.9 607.7 608.1 609.1 14878.1 14924.6 14925.2 14932.0 14945.2 12384.3 12824.9 12950.4 13133.4 13482.9 11022.2 11542.9 11575.6 11771.4 11924.6 3768.9 3772.2 3818.3 3876.9 3948.4 59571.4 59683.7 61492.7 61601.3 61915.0 9907.3 10513.0 10537.4 10664.1 10999.3 19059.7 19685.7 20031.1 20036.7 20044.2 8497.9 8543.8 8544.8 8599.4 8652.9 4726.6 4822.6 4863.4 4867.1 5019.6 3596.9 3672.7 3673.1 3678.8 3684.4 687.1 696.6 703.0 703.5 703.6 602.5 603.1 702.4 707.2 769.0 9492.5 10031.3 10093.2 10099.2 10136.3 594.5 644.5 652.4 670.4 771.9 4394.6 4530.0 4538.5 4546.9 4598.8 67889.3 68639.0 68721.3 70646.3 71169.3 61973.2 62054.9 62080.0 62630.7 63083.0 57108.4 57114.7 57192.6 57584.4 57885.1 8631.2 8718.0 8809.7 8864.5 9031.0 36525.0 37527.4 37706.0 38110.0 38256.4 50139.7 51709.0 51852.0 51912.2 52127.5 11471.0 11607.4 11838.8 11921.3 12034.2 12692.0 13020.2 13032.9 13374.3 13479.5 12234.3 12555.1 12651.7 12713.3 12787.1 12531.9 12662.4 12677.5 12691.6 12778.4 12434.7 13293.3 13569.7 13943.9 13961.4 11054.9 11233.7 11501.1 11521.9 11591.3 11094.4 11877.4 12011.3 12055.2 12279.3 01:36:46 INFO - PROCESS | 10723 | -------- Summary: end -------- 01:36:46 INFO - PROCESS | 10723 | 01:36:47 INFO - TEST-INFO | 10723: exit 0 01:36:47 INFO - TEST-OK | dromaeo_css | took 1113268ms 01:36:47 INFO - TEST-START | kraken 01:36:47 INFO - operating with platform_type : linux_ 01:36:47 INFO - Initialising browser for kraken test... 01:36:47 INFO - TEST-INFO | started process 10899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGLuz7H/profile http://localhost:50563/getInfo.html) 01:36:51 INFO - PROCESS | 10899 | __metrics Screen width/height:1600/1200 01:36:51 INFO - PROCESS | 10899 | colorDepth:24 01:36:51 INFO - PROCESS | 10899 | Browser inner width/height: 1024/697 01:36:51 INFO - PROCESS | 10899 | __metrics 01:36:52 ERROR - PROCESS | 10899 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:36:53 INFO - TEST-INFO | 10899: exit 0 01:36:53 INFO - Browser initialized. 01:36:53 INFO - Running cycle 1/1 for kraken test... 01:36:53 INFO - TEST-INFO | started process 10984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGLuz7H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:37:05 INFO - PROCESS | 10984 | RSS: Main: 155037696 01:37:05 INFO - PROCESS | 10984 | 01:37:07 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50563/tests/kraken/driver.html?testName=audio-beat-detection) 01:37:08 INFO - PROCESS | 10984 | RSS: Main: 214515712 01:37:08 INFO - PROCESS | 10984 | 01:37:11 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50563/tests/kraken/driver.html?testName=audio-dft) 01:37:11 INFO - PROCESS | 10984 | RSS: Main: 198332416 01:37:11 INFO - PROCESS | 10984 | 01:37:14 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50563/tests/kraken/driver.html?testName=audio-fft) 01:37:15 INFO - PROCESS | 10984 | RSS: Main: 269008896 01:37:15 INFO - PROCESS | 10984 | 01:37:17 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50563/tests/kraken/driver.html?testName=audio-oscillator) 01:37:18 INFO - PROCESS | 10984 | RSS: Main: 179650560 01:37:18 INFO - PROCESS | 10984 | 01:37:20 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:37:20 INFO - PROCESS | 10984 | RSS: Main: 183074816 01:37:20 INFO - PROCESS | 10984 | 01:37:23 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50563/tests/kraken/driver.html?testName=imaging-darkroom) 01:37:24 INFO - PROCESS | 10984 | RSS: Main: 217767936 01:37:24 INFO - PROCESS | 10984 | 01:37:27 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50563/tests/kraken/driver.html?testName=imaging-desaturate) 01:37:28 INFO - PROCESS | 10984 | RSS: Main: 219709440 01:37:28 INFO - PROCESS | 10984 | 01:37:31 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50563/tests/kraken/driver.html?testName=json-parse-financial) 01:37:31 INFO - PROCESS | 10984 | RSS: Main: 220401664 01:37:31 INFO - PROCESS | 10984 | 01:37:33 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:37:33 INFO - PROCESS | 10984 | RSS: Main: 208584704 01:37:33 INFO - PROCESS | 10984 | 01:37:35 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:37:36 INFO - PROCESS | 10984 | RSS: Main: 210649088 01:37:36 INFO - PROCESS | 10984 | 01:37:38 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:37:39 INFO - PROCESS | 10984 | RSS: Main: 216072192 01:37:39 INFO - PROCESS | 10984 | 01:37:41 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:37:42 INFO - PROCESS | 10984 | RSS: Main: 224399360 01:37:42 INFO - PROCESS | 10984 | 01:37:45 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:37:45 INFO - PROCESS | 10984 | RSS: Main: 224059392 01:37:45 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | Cycle 1(1): loaded http://localhost:50563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50563/tests/kraken/driver.html?testName=ai-astar) 01:37:47 INFO - PROCESS | 10984 | RSS: Main: 267059200 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | __start_tp_report 01:37:47 INFO - PROCESS | 10984 | _x_x_mozilla_page_load 01:37:47 INFO - PROCESS | 10984 | _x_x_mozilla_page_load_details 01:37:47 INFO - PROCESS | 10984 | |i|pagename|runs| 01:37:47 INFO - PROCESS | 10984 | |0;ai-astar;109;105;109;110;108;108;109;110;110;110 01:37:47 INFO - PROCESS | 10984 | |1;audio-beat-detection;149;132;127;178;128;132;150;124;159;123 01:37:47 INFO - PROCESS | 10984 | |2;audio-dft;160;160;161;161;161;161;161;162;161;162 01:37:47 INFO - PROCESS | 10984 | |3;audio-fft;74;73;74;128;75;75;73;74;98;77 01:37:47 INFO - PROCESS | 10984 | |4;audio-oscillator;84;83;106;84;83;83;128;83;83;129 01:37:47 INFO - PROCESS | 10984 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 01:37:47 INFO - PROCESS | 10984 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;146;146 01:37:47 INFO - PROCESS | 10984 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;95 01:37:47 INFO - PROCESS | 10984 | |8;json-parse-financial;52;52;52;53;52;52;53;52;53;52 01:37:47 INFO - PROCESS | 10984 | |9;json-stringify-tinderbox;60;62;61;60;60;61;62;61;61;61 01:37:47 INFO - PROCESS | 10984 | |10;stanford-crypto-aes;83;85;79;79;80;85;83;83;125;85 01:37:47 INFO - PROCESS | 10984 | |11;stanford-crypto-ccm;125;138;134;128;120;122;118;120;135;135 01:37:47 INFO - PROCESS | 10984 | |12;stanford-crypto-pbkdf2;156;163;160;163;156;157;160;159;164;158 01:37:47 INFO - PROCESS | 10984 | |13;stanford-crypto-sha256-iterative;63;62;63;66;62;64;62;61;63;65 01:37:47 INFO - PROCESS | 10984 | __end_tp_report 01:37:47 INFO - PROCESS | 10984 | __start_cc_report 01:37:47 INFO - PROCESS | 10984 | _x_x_mozilla_cycle_collect,1625 01:37:47 INFO - PROCESS | 10984 | __end_cc_report 01:37:47 INFO - PROCESS | 10984 | __startTimestamp1464683867517__endTimestamp 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | ------- Summary: start ------- 01:37:47 INFO - PROCESS | 10984 | Number of tests: 14 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:1.55 (1.4%) stddev-sans-first:1.64 01:37:47 INFO - PROCESS | 10984 | Values: 109.0 105.0 109.0 110.0 108.0 108.0 109.0 110.0 110.0 110.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:140.50 stddev:18.17 (12.9%) stddev-sans-first:18.99 01:37:47 INFO - PROCESS | 10984 | Values: 149.0 132.0 127.0 178.0 128.0 132.0 150.0 124.0 159.0 123.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 01:37:47 INFO - PROCESS | 10984 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 161.0 162.0 161.0 162.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:17.79 (23.9%) stddev-sans-first:18.63 01:37:47 INFO - PROCESS | 10984 | Values: 74.0 73.0 74.0 128.0 75.0 75.0 73.0 74.0 98.0 77.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:19.22 (23.2%) stddev-sans-first:20.00 01:37:47 INFO - PROCESS | 10984 | Values: 84.0 83.0 106.0 84.0 83.0 83.0 128.0 83.0 83.0 129.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:37:47 INFO - PROCESS | 10984 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:37:47 INFO - PROCESS | 10984 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:37:47 INFO - PROCESS | 10984 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 01:37:47 INFO - PROCESS | 10984 | Values: 52.0 52.0 52.0 53.0 52.0 52.0 53.0 52.0 53.0 52.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 01:37:47 INFO - PROCESS | 10984 | Values: 60.0 62.0 61.0 60.0 60.0 61.0 62.0 61.0 61.0 61.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:13.66 (16.5%) stddev-sans-first:14.43 01:37:47 INFO - PROCESS | 10984 | Values: 83.0 85.0 79.0 79.0 80.0 85.0 83.0 83.0 125.0 85.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:131.00 stddev:7.49 (5.7%) stddev-sans-first:7.89 01:37:47 INFO - PROCESS | 10984 | Values: 125.0 138.0 134.0 128.0 120.0 122.0 118.0 120.0 135.0 135.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:2.95 (1.8%) stddev-sans-first:2.83 01:37:47 INFO - PROCESS | 10984 | Values: 156.0 163.0 160.0 163.0 156.0 157.0 160.0 159.0 164.0 158.0 01:37:47 INFO - PROCESS | 10984 | 01:37:47 INFO - PROCESS | 10984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 01:37:47 INFO - PROCESS | 10984 | Values: 63.0 62.0 63.0 66.0 62.0 64.0 62.0 61.0 63.0 65.0 01:37:47 INFO - PROCESS | 10984 | -------- Summary: end -------- 01:37:47 INFO - PROCESS | 10984 | 01:37:48 INFO - TEST-INFO | 10984: exit 0 01:37:48 INFO - TEST-OK | kraken | took 61210ms 01:37:48 INFO - SUITE-END | took 1174s 01:37:48 INFO - Completed test suite (00:19:34) 01:37:48 INFO - javascript benchmark 01:37:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.457244982128, 3112.875484980601, 3139.403513332466, 3157.41587806256, 3175.491921292592, 5284.8150314739, 5359.5444387227035, 5372.113601255793, 5415.83752487425, 5493.5055844973895, 5316.654417462872, 5364.0, 5437.157240627709, 5440.537554307879, 5468.6171967962255, 4837.008413275279, 4878.463369029404, 4893.41279046515, 4901.411830580318, 5108.770105345268, 5006.5744411725045, 5014.373203349582, 5040.395152581696, 5060.987802439508, 5065.6200784941275, 4858.02839432115, 4894.755262236892, 4912.508749125094, 4955.578775804061, 4964.602831773467, 4899.363082799249, 4907.533784290486, 4912.533309335608, 4928.926066109011, 4953.653244272902, 4916.041371932474, 4947.653664243504, 4954.033963377143, 4964.702117872939, 4967.975160124212, 5164.974175129138, 5331.413544510101, 5391.406945236021, 5404.243405923174, 5405.594580406446, 5855.268091488564, 5911.172435858984, 5917.792877249276, 5918.674472903988, 5921.023031199847, 5889.8822023559715, 5947.613405128696, 5957.314908785502, 5957.434043765836, 5962.761489540413, 5321.893562128775, 5437.265969094161, 5482.122860342366, 5486.945130548684, 5543.861403464945, 6025.0359942409, 6031.4270144336215, 6032.095185722177, 6039.4262545058145, 6040.124181993587, 5543.916841247385, 5806.738696758656, 5807.970960145257, 5810.070388737781, 5814.0, 5720.313562372458, 5761.9135712964335, 5768.105943578752, 5780.768769249267, 5802.100674395391, 5766.596338256366, 5772.076467765138, 5774.740136693859, 5777.711114444261, 5778.27771528559, 5580.553555715533, 5704.657720536781, 5727.513161381329, 5782.739776710058, 5789.8552536186935, 4396.538363471789, 4423.20382331177, 4427.667924905645, 4465.799039043251, 4467.664925130628, 3926.2932672118723, 3938.468306778548, 3948.7038472114705, 3962.3462128748433, 3982.7809470478824, 5353.250544923714, 5384.596155288369, 5407.540359069444, 5526.088195447706, 5533.03171944908, 5746.367899531048, 5762.596618236683, 5789.739461724233, 5796.739146738407, 5847.853803654943, 5450.727463626882, 5459.262999495097, 5459.781608735606, 5474.698891561003, 5477.28795256622, 4858.46556878743, 4952.727599982036, 4955.801767929314, 4973.676711013773, 5000.174971129795, 6020.488258498077, 6024.945634513942, 6028.909566356509, 6030.095485677096, 6080.0879868019265, 5826.009578371687, 5833.854153646023, 5837.737301821513, 5858.619189752652, 5860.09168578871, 5891.528677705687, 5913.053911374332, 5931.288245410578, 5950.285965684146, 6027.78902738402, 5646.040173170489, 5688.431156884279, 5696.658200507983, 5700.800471983461, 5714.914276285942, 5804.506616937608, 5814.186013958134, 5819.5344372450945, 5824.970875145597, 5826.096954971986, 5456.09974354243, 5662.405447427961, 5694.373618902, 5715.542756579547, 5736.913946290892, 5688.829335119953, 5690.630109042899, 5693.715314234189, 5699.145128230799, 5702.059160238514, 5507.779688812403, 5607.663540187602, 5613.775448981995, 5614.21401003868, 5618.0, 5729.28383952006, 5762.7694892203845, 5773.336066352424, 5849.415058494116, 5853.239078919713, 5675.489205971482, 5676.914846277392, 5678.176664383559, 5699.2590963174525, 5724.427557244242], "value": 5356.105504339815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.6052467207994, 643.154252158412, 651.3974573519494, 651.8402991267137, 658.3383699382117, 31509.369812603734, 34366.48450273248, 34384.31231375374, 34398.312033759306, 34470.793522226755, 34981.65018349816, 43807.561924380745, 44617.55382446183, 44731.0, 48168.51831481684, 8656.523891185981, 8815.074417186199, 8822.823543529126, 8823.64705411786, 8839.513826739527, 8551.273141782956, 8622.698205562807, 8684.782880427976, 8688.956555217246, 8694.17405346491, 8697.217250447458, 8713.651453941835, 8743.344249181306, 8745.606447709837, 8752.168543988342, 8663.39356245063, 8707.0, 8721.912780872173, 8725.563721813884, 8725.912740872605, 8698.999615044288, 8775.429597076234, 8780.297576193952, 8789.165029322205, 8796.736097917073, 41055.0, 41467.0, 41479.37780933289, 41501.377479337534, 41506.54727084568, 3438.1404648837793, 3608.747387682863, 4145.0, 4194.601512856304, 4284.742915425053, 31368.215794605316, 31750.364992700015, 31774.364512709617, 31903.84048079768, 33678.6632133678, 4219.767912764797, 4408.625266852321, 4420.20436321462, 4482.663800214997, 4490.438695163105, 336183.0, 337232.0, 337543.0, 338003.0, 338081.0, 56200.71899640557, 56647.716761416756, 56723.0, 56900.71549642225, 57002.144967825516, 59360.40639593635, 59374.40625593689, 59478.40521594815, 59479.40520594825, 59531.0, 16110.75833862493, 16276.10481423533, 16313.918430407772, 16321.265543050591, 16323.510294691177, 13070.215787052808, 13132.737345253041, 13134.474621015244, 13146.342682865818, 13149.868501315055, 14195.432182712782, 15811.683766324839, 15832.525024249291, 15887.205639717968, 15888.682226355408, 5207.843764687065, 5790.536757059425, 5930.822075337746, 6101.389861013863, 6120.7551697931585, 978.8287049766262, 1012.9392583341936, 1032.7986042721748, 1115.1524841120806, 1148.1388958281289, 31581.210469738442, 32231.0, 32284.35431291361, 32498.35003299921, 32921.0, 1102.9779404412027, 1143.2168964259508, 1150.327058670687, 1157.7337212441187, 1166.2943918928927, 16777.664446710998, 17135.22891469887, 17152.742708859376, 17378.39175628847, 17445.651086978443, 514110.0, 515360.0, 516508.0, 518628.0, 519355.0, 56856.43143568594, 56928.43071569314, 56943.14585281224, 56961.715191424606, 57012.149392530206, 1290.7934730443085, 1363.8840698540735, 1386.0644065255913, 1416.723738870931, 1428.5071650280636, 31606.683933160373, 32474.0, 32511.18722031968, 32668.346633067682, 32963.67036329702, 48633.082015079206, 48644.0, 49063.75468122637, 49130.50869491259, 49186.0, 385991.0, 386269.0, 386577.0, 387007.0, 388227.0, 24135.39661508406, 26655.0, 26985.73014269832, 27437.31406714848, 28243.435131296847, 44919.55080449284, 45261.54738452705, 45409.31886021646, 46011.0, 46097.769511152226, 36847.44728829123, 39220.41169382518, 39387.80306098566, 39535.40696889492, 40757.1848563033, 39002.0, 39578.0, 39751.0, 40011.59988400079, 40089.0, 38594.42108368433, 39206.215875682894, 39752.403713943735, 39764.0, 39767.80116099401, 32332.67667323391, 35411.33047635542, 35781.28437431289, 35836.10409739777, 36047.0, 26993.190204293904, 27405.58891616667, 27631.0, 27638.86180569084, 27860.0], "value": 19531.676365483036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3134426687695, 390.68940192546927, 394.6527056190552, 397.8070635741665, 417.6032768869573, 18172.36396726115, 19193.0, 19641.312554060594, 19654.21383144674, 19699.212031518757, 17977.0, 18493.53766155847, 18624.44126676202, 18767.718484222747, 19012.809871901278, 5671.177679236519, 5794.39158888317, 5798.681072541009, 5842.912356314638, 5845.240118784552, 5673.461021202979, 5763.423657634224, 5771.451712087345, 5773.076307790754, 5793.565482588801, 5584.301962254718, 5688.146777983315, 5727.971360143193, 5747.1666608341975, 5758.539316854642, 5640.153976903456, 5650.434956504358, 5706.087026075808, 5737.9713101434645, 5742.339630942432, 5062.645614806928, 5413.621046526705, 5415.593830462731, 5456.699881506515, 5476.726163691839, 13457.798133028013, 13544.255065971367, 13750.243736594482, 13764.862351376458, 13850.238236896967, 2196.560687862418, 2278.236790675126, 2342.5900467418305, 2371.4664200554907, 2830.5754136879427, 9521.962667939579, 9767.462789546573, 9900.417379336504, 9991.450470224136, 10245.74385640365, 1645.539249010279, 1756.6398888228011, 1879.2483006797254, 1899.4871384726046, 1936.912838922252, 80822.59588702078, 85312.0, 85313.57343213307, 85703.57148214281, 85875.57062214712, 10237.464380343008, 10494.527746251284, 10555.525001374957, 10614.734631634117, 11319.434028298552, 14324.14055156694, 14370.0, 14435.927820361041, 14441.566752997427, 14453.78319325211, 7927.5243485391065, 7948.324392426708, 8044.597770111588, 8210.384221183434, 8254.504729716236, 7604.239576042462, 7742.729004484816, 7768.533887966627, 7888.7633370998965, 7914.683412663429, 4456.710313829591, 4460.843870464518, 4467.989404767867, 4469.843555475542, 4521.547845215452, 1925.4801203674929, 1926.1428664244556, 1940.3693799515213, 1970.8029197080177, 1972.7139564763315, 876.8640860666607, 957.0955447102422, 1017.0084167936203, 1018.3787889387468, 1044.5351818440872, 16784.916075419787, 17887.463376098738, 18103.72844407335, 18236.63526729458, 19955.20179192845, 972.5817898303798, 992.7766252593109, 1006.2402885821305, 1020.2552136940076, 1028.290479569095, 10484.26610137283, 10492.160627149962, 10632.893671063344, 10698.304610200312, 10708.357498550113, 480253.0, 490681.0, 499833.0, 502189.0, 502215.0, 60767.08849367263, 69817.0, 84944.0, 85693.57153214194, 92359.0, 1002.644061358222, 1006.7483129217695, 1031.7111208861681, 1042.1923009667416, 1045.5504133222787, 12566.711307441845, 16262.268197931358, 16627.584310392336, 16850.74723879167, 16986.575335616708, 41375.58624413717, 41580.58419415767, 42842.5715742851, 42846.785766072215, 43099.35350969675, 54394.0, 55515.72242138763, 55703.442965569826, 56424.71787641035, 57435.71282143563, 8194.959025204837, 8205.220504052106, 8362.87455688153, 8524.786880328042, 8716.084811094745, 11874.584389546324, 12757.170783899017, 12840.0, 12854.935725321313, 12875.227486350848, 5935.614185077956, 8248.54632995191, 10738.516766745359, 10810.13518918469, 10877.67366978992, 10907.509162087883, 10982.341059536133, 11142.997130258316, 11287.830682539605, 11449.026832719312, 10790.352578845295, 10919.126469882549, 10935.179861510578, 10937.781244375226, 11044.447777611247, 8038.557879316693, 8153.959230203811, 8271.751847444586, 8407.369447291356, 8643.438176518506, 9975.20198384142, 10749.301295415773, 10830.566777328819, 10844.620438284623, 10936.234463587472], "value": 8814.322599517125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.27185863351, 1516.9241537923106, 1562.914039727815, 1693.8814283000188, 1858.6282743451313, 8640.179182977616, 8961.417507861985, 8971.91028089719, 9261.0, 9277.628894844214, 8999.640014399416, 9208.953955230214, 9209.355345125843, 9211.309151813608, 9214.308926830498, 2338.240071976606, 2362.185046159081, 2364.243442098529, 2365.503244318695, 2365.9171928982405, 2242.8878556072214, 2275.4311422144465, 2278.897449614763, 2287.5996700577416, 2289.9885500572473, 2348.189874493297, 2351.623740201568, 2366.893489792955, 2380.7262164851004, 2384.0940442631777, 2222.1666874921902, 2252.121672547716, 2261.4685548895995, 2280.099360752502, 2341.4731685370825, 2300.332903457995, 2301.2290882554366, 2303.9632165525413, 2307.2501437033034, 2320.071971211512, 8729.60716767747, 8917.687880924137, 8961.462312261285, 9098.909010909872, 9098.909010909872, 5374.758135883894, 5518.724063796794, 5519.530839878616, 5520.006398848206, 5523.088690366085, 3381.898543043713, 3459.8616055358007, 3489.4068008438626, 3510.912227194315, 3511.051366491596, 1162.1806626328419, 1181.5746331320804, 1190.4523918997186, 1193.8328633991248, 2116.2698868890207, 12756.2984035878, 12828.102032857703, 12853.421596028202, 12859.678508037281, 12870.16343937641, 4470.173017991682, 4551.135284295973, 4615.930761038587, 4616.792244349012, 4690.0, 9972.850407243897, 9975.301728878909, 10008.149307308815, 10019.448930308903, 10032.097111260022, 5337.2794672719465, 5346.518813306821, 5347.438518955531, 5353.2237825515085, 5355.410904800468, 4134.3178375567695, 4224.324108142682, 4339.500957389878, 4913.459519452857, 4949.381327334083, 3739.607341229186, 3758.229562939591, 3785.3186426443503, 3823.5029446172375, 3884.533855937306, 1066.8826429092794, 1078.078243102152, 1079.0504356166523, 1080.9297395669257, 1084.1056128693701, 843.5107637570195, 946.9100435458621, 1010.6109147977934, 1011.9139873110721, 1052.7894421115807, 6198.81403557894, 6247.0, 6308.148399966038, 6433.710483028275, 6439.098526206335, 905.76902889764, 1008.0, 1015.081351377005, 1021.1575450253571, 1049.532957833772, 4343.82624695015, 4371.934420983688, 4412.646988240997, 4437.267850804646, 4451.1765323415275, 11388.145889058354, 11795.174337796443, 11863.70340741471, 11874.0, 11876.762464750656, 10851.186161037953, 11211.439428028565, 11629.88370116288, 11742.823857642143, 11750.764984700429, 8401.285890699237, 8466.068732439428, 8512.978442586806, 8550.187732165434, 8573.27127194183, 6126.785562505291, 6425.614463132227, 6443.838904027437, 6482.57863238888, 6504.869902602016, 10362.963703629577, 10416.375017498975, 10639.468026598794, 10680.83978740335, 10681.985211404904, 10638.787224255626, 10770.407627580245, 10810.18923580719, 10816.621418250323, 10866.0, 7425.14610819741, 7838.725644602411, 8008.919910800817, 8039.075506316614, 8312.459690120122, 8929.241014513838, 8946.329025322997, 8967.820643587222, 9003.594838232426, 9041.095890410907, 8115.269625733712, 8140.552269624991, 8180.877286840821, 8229.506229626242, 8295.875561866698, 8005.0, 8040.758777236692, 8043.0, 8079.394045446497, 8271.296939760188, 7282.854342913218, 7384.224656410999, 7386.15059268191, 7388.926110739038, 7392.55644661322, 5116.948830511647, 5278.0, 5387.622866399314, 5434.483724046209, 5542.528885044655, 5336.599755018467, 5399.5950303726595, 5450.127979523258, 5455.809046683347, 5526.640768350045], "value": 4773.774022486495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.71730311931736, 329.63410614218213, 333.4614597425158, 337.9645137260588, 338.0450228105602, 5374.5700343972485, 5398.676079435237, 5402.6758394496355, 5421.1326187809955, 5446.0, 5261.815836445725, 5268.841934741954, 5344.171653393731, 5358.866028349294, 5383.865403364918, 3973.8410463581495, 4076.7757773322455, 4209.536950935395, 4212.55768144345, 4234.322508398657, 4147.460830092084, 4164.500259968793, 4180.24755544002, 4199.7690127043, 4199.992001919532, 3973.3046716824583, 4159.688023398242, 4161.292580261363, 4162.396452514398, 4176.290030694774, 4057.6204090609335, 4061.776602286873, 4085.346344584867, 4127.545969943304, 4135.855245066438, 3636.4908912752235, 3663.8900832975055, 3667.8899633010788, 3673.045008297835, 3690.1881586051295, 5068.873278168038, 5069.974650126763, 5079.034983353151, 5085.0, 5103.336566246364, 4582.725036497787, 4736.407949006374, 4772.403449568804, 4782.784774685148, 4804.783784729696, 5465.426130256305, 5479.342478902558, 5484.862878428032, 5508.614396992212, 5522.420145884705, 3859.5754467008605, 3998.5001874765653, 4026.4362989181536, 4033.8184781684895, 4056.391541268804, 5757.251557297524, 5761.876434095353, 5764.135379692996, 5780.8843823123725, 5781.335146458127, 4032.6370626643156, 4039.8688367257214, 4042.757434553936, 4061.147159096564, 4063.4152680454645, 3915.1778126593163, 4102.671786257092, 4107.028626259412, 4108.424820525129, 4147.771872546979, 4664.976675116671, 4691.741954192552, 4699.647526435531, 4700.435947686231, 4706.599939005155, 5501.669899806025, 5527.309086364205, 5554.305711786027, 5559.527440167551, 5580.86047848807, 1360.768669326217, 1402.8737413632823, 1414.3564678071452, 1422.5021242565226, 1431.255747011569, 904.0733248420422, 905.7101727447285, 909.377076702461, 922.7923717163585, 960.1071003966379, 5308.150695888639, 5338.572914166935, 5357.0, 5366.973165134149, 5367.0, 5664.0, 5673.319201695823, 5682.261306030189, 5695.7152142392715, 5708.40061793514, 5253.658512196772, 5258.605604579672, 5337.706426146521, 5355.135002773497, 5378.91931621026, 3020.1845501714415, 3047.527633216855, 3052.0996306089755, 3052.4047810676707, 3056.43455960648, 5677.37548869624, 5906.616069955439, 5915.497182739516, 5921.683857040071, 5939.46544810969, 5769.798057067983, 5784.88430231393, 5789.739461724233, 5803.158542011384, 5808.186853840466, 5787.5080618147085, 5827.504662103769, 5830.038043722739, 5840.773437578071, 5900.173975643499, 5502.477264659851, 5716.28546431696, 5726.484616384545, 5885.47030767233, 5886.852828679317, 5763.625364351304, 5792.189093526994, 5809.651420914759, 5816.883662326814, 5817.312979235974, 5720.6853623049465, 6067.332593414632, 6110.816675499742, 6111.388861114031, 6135.202423684892, 4005.339119045325, 4012.518497780285, 4025.033991841878, 4034.5360283566592, 4038.293298672779, 5785.190073389813, 5807.070868660994, 5821.446962538552, 5848.0, 5862.267216597926, 5437.4562543745305, 5670.3272534601565, 5695.601307908407, 5702.714864256854, 5736.852629474205, 5554.722413844919, 5579.8047068354035, 5641.210230567642, 5653.406392328746, 5658.688772117573, 5357.303550538405, 5402.51377376038, 5531.391546929915, 5572.498475137257, 5630.4369563043365, 5611.158326251095, 5616.522595579421, 5624.85937851557, 5661.547076233974, 5677.829665110054, 5518.917216241679, 5546.306711661043, 5549.529374715784, 5552.444755524577, 5556.333240011225], "value": 4255.422973561349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.9920800791992, 834.987475187872, 838.0488145954348, 844.7803571071521, 844.8394804987053, 16486.50540483786, 17065.402710905106, 17070.231839567234, 17595.12024398778, 17728.37950671727, 15652.686946261096, 15702.214889255549, 15759.054456732576, 15794.605134871605, 15820.0, 678.5555461172939, 796.1083586383245, 798.4530596541359, 800.9159038300982, 801.5431204213601, 792.6433105102698, 792.9801754956114, 797.5693125712138, 813.4265342933218, 814.6130587970696, 838.2413915406567, 840.8234270803108, 841.9957900210521, 843.8017065989487, 844.1136806353335, 710.2684235237714, 714.1679942866555, 841.7853447370942, 842.0653075086649, 842.4860834890711, 592.3277080513604, 592.8873514032321, 607.6536374266669, 608.084832327349, 609.05596325695, 14878.10731356122, 14924.62688432787, 14925.179115148663, 14932.0, 14945.17801520916, 12384.318862462562, 12824.935875320656, 12950.352482375843, 13133.408996595175, 13482.932585337108, 11022.228444008922, 11542.935544486476, 11575.594854180063, 11771.352575608338, 11924.642260732191, 3768.8869333920024, 3772.2266935278203, 3818.3317919364276, 3876.8643097491454, 3948.4077388391684, 59571.40428595702, 59683.70158149225, 61492.69253653703, 61601.33237216942, 61915.0, 9907.306488545877, 10513.0, 10537.420441875616, 10664.146868250522, 10999.34003959765, 19059.714104288447, 19685.704714429296, 20031.09860056301, 20036.69944950827, 20044.198232070554, 8497.915020849712, 8543.829123417621, 8544.786380340416, 8599.398042137116, 8652.913470865336, 4726.574608285271, 4822.590079843182, 4863.392075990501, 4867.123917694778, 5019.573336266385, 3596.892093237207, 3672.7245456590863, 3673.1368128489785, 3678.834452449646, 3684.3552378333684, 687.1273482676972, 696.613379574331, 702.9543079699803, 703.4583370804452, 703.63762662229, 602.5330368964001, 603.1043899808781, 702.3854127638316, 707.2220557386936, 768.9692412303557, 9492.477913714674, 10031.347962382568, 10093.192544596415, 10099.242556808269, 10136.341137826017, 594.4501336263938, 644.490852226745, 652.3704625036768, 670.4401824476616, 771.8996530451005, 4394.648428125743, 4529.9547004530195, 4538.478075021349, 4546.88632784183, 4598.793054312564, 67889.32110678928, 68639.0, 68721.3127868715, 70646.293537065, 71169.2883071173, 61973.22311079159, 62054.932858728076, 62080.0, 62630.68684656548, 63083.0, 57108.42891571197, 57114.7144264276, 57192.56670616285, 57584.42415575791, 57885.13172302419, 8631.180037896389, 8718.0, 8809.735707928772, 8864.512451815212, 9031.0, 36525.0, 37527.43708844315, 37706.0, 38110.0, 38256.426153607164, 50139.74930125326, 51709.0, 51852.0, 51912.221316679526, 52127.47872521378, 11471.0, 11607.361595112012, 11838.763224735629, 11921.344326061802, 12034.157608967289, 12692.048096392622, 13020.218786872818, 13032.869671303166, 13374.264415457243, 13479.528216512375, 12234.300833391082, 12555.121141520005, 12651.746965060831, 12713.300768457824, 12787.104902656725, 12531.93734031324, 12662.430190641258, 12677.492900283885, 12691.619251422471, 12778.361081946052, 12434.689132771391, 13293.281980361127, 13569.660758481117, 13943.930280348533, 13961.441542338192, 11054.944725276644, 11233.71915702114, 11501.137414694098, 11521.88478115208, 11591.304521728724, 11094.44527773592, 11877.406129693309, 12011.339376334385, 12055.15613907018, 12279.324637145042], "value": 6990.538367629381, "unit": "score"}], "name": "dromaeo_css", "value": 7126.163990803189, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 109.0, 110.0, 108.0, 108.0, 109.0, 110.0, 110.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 127.0, 178.0, 128.0, 132.0, 150.0, 124.0, 159.0, 123.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 128.0, 75.0, 75.0, 73.0, 74.0, 98.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 84.0, 83.0, 83.0, 128.0, 83.0, 83.0, 129.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 52.0, 52.0, 53.0, 52.0, 53.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 79.0, 79.0, 80.0, 85.0, 83.0, 83.0, 125.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 138.0, 134.0, 128.0, 120.0, 122.0, 118.0, 120.0, 135.0, 135.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 163.0, 160.0, 163.0, 156.0, 157.0, 160.0, 159.0, 164.0, 158.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 66.0, 62.0, 64.0, 62.0, 61.0, 63.0, 65.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1493.8999999999999, "alertThreshold": 2.0}]} 01:37:48 INFO - Return code: 0 01:37:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:37:48 ERROR - # TBPL SUCCESS # 01:37:48 INFO - Running post-action listener: _resource_record_post_action 01:37:48 INFO - ##### 01:37:48 INFO - ##### Finished run-tests step (success) 01:37:48 INFO - ##### 01:37:48 INFO - Running post-run listener: _resource_record_post_run 01:37:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550608896; Read time: 16; Write time: 1285904 01:37:48 INFO - TinderboxPrint: CPU usage
13.2% 01:37:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:37:48 INFO - TinderboxPrint: I/O write bytes / time
550,608,896 / 1,285,904 01:37:48 INFO - TinderboxPrint: CPU idle
8,270.0 (86.8%) 01:37:48 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 01:37:48 INFO - TinderboxPrint: Swap in / out
0 / 0 01:37:48 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 259825664; Read time: 0; Write time: 807552 01:37:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290783232; Read time: 16; Write time: 478352 01:37:49 INFO - Running post-run listener: _upload_blobber_files 01:37:49 INFO - Blob upload gear active. 01:37:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:37:49 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 01:37:49 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'] 01:37:49 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 01:37:49 INFO - (blobuploader) - INFO - Open directory for files ... 01:37:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:37:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:53 INFO - (blobuploader) - INFO - Done attempting. 01:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:54 INFO - (blobuploader) - INFO - Done attempting. 01:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:54 INFO - (blobuploader) - INFO - Done attempting. 01:37:54 INFO - (blobuploader) - INFO - Iteration through files over. 01:37:54 INFO - Return code: 0 01:37:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:37:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:37:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230f31726bb6764bdeb951c66552e29d524c40264ea90f69e65deea9b0a18502db052b8c27da946b9c870d92dfd5887bfea4a9f7301bb796ac18018c3f6b302f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01594c3f686d1f02945785520b954332d2ac4e5885b37949aff217a08e5f4c047000e32051c15fce44a373409e485aa5c8107f9a9e85f70714a492ad9ab1143c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bd0dec5bb9b986eddc84259b147567fbb2d8f7434654919a7bec012a5a2ea0709814ce0b5b38b02347cc3a0318b58f80025f567f2c9bd5fe1a338bf36120e2"} 01:37:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:37:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:37:54 INFO - Contents: 01:37:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230f31726bb6764bdeb951c66552e29d524c40264ea90f69e65deea9b0a18502db052b8c27da946b9c870d92dfd5887bfea4a9f7301bb796ac18018c3f6b302f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01594c3f686d1f02945785520b954332d2ac4e5885b37949aff217a08e5f4c047000e32051c15fce44a373409e485aa5c8107f9a9e85f70714a492ad9ab1143c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bd0dec5bb9b986eddc84259b147567fbb2d8f7434654919a7bec012a5a2ea0709814ce0b5b38b02347cc3a0318b58f80025f567f2c9bd5fe1a338bf36120e2"} 01:37:54 INFO - Running post-run listener: copy_logs_to_upload_dir 01:37:54 INFO - Copying logs to upload dir... 01:37:54 INFO - mkdir: /builds/slave/test/build/upload/logs 01:37:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.450583 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 01:37:54.172322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 01:37:54.176493) ========= 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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 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/230f31726bb6764bdeb951c66552e29d524c40264ea90f69e65deea9b0a18502db052b8c27da946b9c870d92dfd5887bfea4a9f7301bb796ac18018c3f6b302f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01594c3f686d1f02945785520b954332d2ac4e5885b37949aff217a08e5f4c047000e32051c15fce44a373409e485aa5c8107f9a9e85f70714a492ad9ab1143c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bd0dec5bb9b986eddc84259b147567fbb2d8f7434654919a7bec012a5a2ea0709814ce0b5b38b02347cc3a0318b58f80025f567f2c9bd5fe1a338bf36120e2"} build_url:https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/ClPct6RJS-mcoP5Bwb9CZQ/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/230f31726bb6764bdeb951c66552e29d524c40264ea90f69e65deea9b0a18502db052b8c27da946b9c870d92dfd5887bfea4a9f7301bb796ac18018c3f6b302f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01594c3f686d1f02945785520b954332d2ac4e5885b37949aff217a08e5f4c047000e32051c15fce44a373409e485aa5c8107f9a9e85f70714a492ad9ab1143c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bd0dec5bb9b986eddc84259b147567fbb2d8f7434654919a7bec012a5a2ea0709814ce0b5b38b02347cc3a0318b58f80025f567f2c9bd5fe1a338bf36120e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 01:37:54.202291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:37:54.202612) ========= 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=af724c981e2a0f424dbabf99000001e7-1464682637.835738-1453142550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:37:54.291201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 01:37:54.291559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 01:37:54.291939) ========= ========= Total master_lag: 0.17 =========