builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1463378898.01 results: success (0) buildid: 20160515203030 builduid: 02e0608df6234392a70b43c1c3665b4f revision: 7084bd828e4c688daf6078a710d2f267bb52591a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.011371) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.011838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.012117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.032803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.033068) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-15 23:08:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-05-15 23:08:19 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.147049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.147356) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.197154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.197537) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7084bd828e4c688daf6078a710d2f267bb52591a --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 7084bd828e4c688daf6078a710d2f267bb52591a --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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-15 23:08:19,520 truncating revision to first 12 chars 2016-05-15 23:08:19,520 Setting DEBUG logging. 2016-05-15 23:08:19,520 attempt 1/10 2016-05-15 23:08:19,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7084bd828e4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-15 23:08:19,845 unpacking tar archive at: fx-team-7084bd828e4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.838296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.838615) ========= script_repo_revision: 7084bd828e4c688daf6078a710d2f267bb52591a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.839000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.839263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 23:08:18.849308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-15 23:08:18.849673) ========= /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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:08:20 INFO - MultiFileLogger online at 20160515 23:08:20 in /builds/slave/test 23:08:20 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 23:08:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:08:20 INFO - {'append_to_log': False, 23:08:20 INFO - 'base_work_dir': '/builds/slave/test', 23:08:20 INFO - 'blob_upload_branch': 'Fx-Team', 23:08:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:08:20 INFO - 'branch': 'Fx-Team', 23:08:20 INFO - 'buildbot_json_path': 'buildprops.json', 23:08:20 INFO - 'config_files': ('talos/linux_config.py',), 23:08:20 INFO - 'default_actions': ('clobber', 23:08:20 INFO - 'read-buildbot-config', 23:08:20 INFO - 'download-and-extract', 23:08:20 INFO - 'populate-webroot', 23:08:20 INFO - 'create-virtualenv', 23:08:20 INFO - 'install', 23:08:20 INFO - 'run-tests'), 23:08:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:08:20 INFO - 'download_minidump_stackwalk': True, 23:08:20 INFO - 'download_symbols': 'ondemand', 23:08:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:08:20 INFO - 'tooltool.py': '/tools/tooltool.py', 23:08:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:08:20 INFO - '/tools/misc-python/virtualenv.py')}, 23:08:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:08:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:08:20 INFO - 'installer_path': 'installer.exe', 23:08:20 INFO - 'log_level': 'info', 23:08:20 INFO - 'log_name': 'talos', 23:08:20 INFO - 'log_to_console': True, 23:08:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:08:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:08:20 INFO - 'opt_config_files': (), 23:08:20 INFO - 'pip_index': False, 23:08:20 INFO - 'sps_profile': False, 23:08:20 INFO - 'sps_profile_interval': 0, 23:08:20 INFO - 'suite': 'dromaeojs', 23:08:20 INFO - 'system_bits': '32', 23:08:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:08:20 INFO - 'title': 'talos-linux64-ix-060', 23:08:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:08:20 INFO - 'use_talos_json': True, 23:08:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:08:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:08:20 INFO - 'work_dir': 'build'} 23:08:20 INFO - ##### 23:08:20 INFO - ##### Running clobber step. 23:08:20 INFO - ##### 23:08:20 INFO - Running pre-action listener: _resource_record_pre_action 23:08:20 INFO - Running main action method: clobber 23:08:20 INFO - rmtree: /builds/slave/test/build 23:08:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:08:21 INFO - Running post-action listener: _resource_record_post_action 23:08:21 INFO - ##### 23:08:21 INFO - ##### Finished clobber step (success) 23:08:21 INFO - ##### 23:08:21 INFO - ##### 23:08:21 INFO - ##### Running read-buildbot-config step. 23:08:21 INFO - ##### 23:08:21 INFO - Running pre-action listener: _resource_record_pre_action 23:08:21 INFO - Running main action method: read_buildbot_config 23:08:21 INFO - Using buildbot properties: 23:08:21 INFO - { 23:08:21 INFO - "project": "", 23:08:21 INFO - "product": "firefox", 23:08:21 INFO - "script_repo_revision": "production", 23:08:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:08:21 INFO - "repository": "", 23:08:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:08:21 INFO - "buildid": "20160515203030", 23:08:21 INFO - "pgo_build": "True", 23:08:21 INFO - "basedir": "/builds/slave/test", 23:08:21 INFO - "buildnumber": 90, 23:08:21 INFO - "slavename": "talos-linux64-ix-060", 23:08:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:08:21 INFO - "platform": "ubuntu64_hw", 23:08:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:08:21 INFO - "branch": "fx-team", 23:08:21 INFO - "repo_path": "integration/fx-team", 23:08:21 INFO - "revision": "7084bd828e4c688daf6078a710d2f267bb52591a", 23:08:21 INFO - "stage_platform": "linux64-pgo", 23:08:21 INFO - "builduid": "02e0608df6234392a70b43c1c3665b4f", 23:08:21 INFO - "slavebuilddir": "test" 23:08:21 INFO - } 23:08:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:08:21 INFO - Running post-action listener: _resource_record_post_action 23:08:21 INFO - ##### 23:08:21 INFO - ##### Finished read-buildbot-config step (success) 23:08:21 INFO - ##### 23:08:21 INFO - ##### 23:08:21 INFO - ##### Running download-and-extract step. 23:08:21 INFO - ##### 23:08:21 INFO - Running pre-action listener: _resource_record_pre_action 23:08:21 INFO - Running main action method: download_and_extract 23:08:21 INFO - mkdir: /builds/slave/test/build/tests 23:08: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')]} 23:08:21 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:26 INFO - Downloaded 1361 bytes. 23:08:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:26 INFO - Using the following test package requirements: 23:08:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:08:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:08:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'jsshell-linux-x86_64.zip'], 23:08:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:08:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:08:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:08:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:08:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:08:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:26 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:28 INFO - Downloaded 24023288 bytes. 23:08:28 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'] 23:08:28 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 23:08:29 INFO - Return code: 0 23:08:29 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 23:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:29 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:46 INFO - Downloaded 24023288 bytes. 23:08:46 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'] 23:08:46 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 23:08:48 INFO - Return code: 0 23:08: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')]} 23:08:48 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:49 INFO - Downloaded 10840194 bytes. 23:08:49 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'] 23:08:49 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 23:08:49 INFO - Return code: 0 23:08:49 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')]} 23:08:49 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:08:51 INFO - Downloaded 58394741 bytes. 23:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:51 INFO - mkdir: /builds/slave/test/properties 23:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:08:51 INFO - Contents: 23:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:08:52 INFO - Running post-action listener: _resource_record_post_action 23:08:52 INFO - Running post-action listener: set_extra_try_arguments 23:08:52 INFO - ##### 23:08:52 INFO - ##### Finished download-and-extract step (success) 23:08:52 INFO - ##### 23:08:52 INFO - ##### 23:08:52 INFO - ##### Running populate-webroot step. 23:08:52 INFO - ##### 23:08:52 INFO - Running pre-action listener: _resource_record_pre_action 23:08:52 INFO - Running main action method: populate_webroot 23:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:08:52 INFO - '--tppagecycles', 23:08:52 INFO - '7'], 23:08:52 INFO - 'tests': ['tsvgm']}}, 23:08:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:08:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:08:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:08:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['damp', 'tps']}, 23:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'tests': ['damp', 'tps']}, 23:08:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['dromaeo_dom']}, 23:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:08:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['a11yr', 23:08:52 INFO - 'ts_paint', 23:08:52 INFO - 'tpaint', 23:08:52 INFO - 'sessionrestore', 23:08:52 INFO - 'sessionrestore_no_auto_restore', 23:08:52 INFO - 'tabpaint']}, 23:08:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['tsvgx', 23:08:52 INFO - 'tsvgr_opacity', 23:08:52 INFO - 'tart', 23:08:52 INFO - 'tscrollx', 23:08:52 INFO - 'cart']}, 23:08:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:08:52 INFO - 'tsvgr_opacity', 23:08:52 INFO - 'tart', 23:08:52 INFO - 'tscrollx', 23:08:52 INFO - 'cart']}, 23:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'talos_options': ['--disable-e10s'], 23:08:52 INFO - 'tests': ['tp5o']}, 23:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'tests': ['tp5o']}, 23:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'talos_options': ['--disable-e10s', 23:08:52 INFO - '--xperf_path', 23:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:52 INFO - 'tests': ['tp5n']}, 23:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:52 INFO - 'talos_options': ['--xperf_path', 23:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:52 INFO - 'tests': ['tp5n']}}, 23:08:52 INFO - 'talos.zip': {'path': '', 23:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:08:52 INFO - Running post-action listener: _resource_record_post_action 23:08:52 INFO - ##### 23:08:52 INFO - ##### Finished populate-webroot step (success) 23:08:52 INFO - ##### 23:08:52 INFO - ##### 23:08:52 INFO - ##### Running create-virtualenv step. 23:08:52 INFO - ##### 23:08:52 INFO - Running pre-action listener: _resource_record_pre_action 23:08:52 INFO - Running main action method: create_virtualenv 23:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:08:52 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 23:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:08:52 INFO - Using real prefix '/usr' 23:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:08:52 INFO - Installing distribute.............................................................................................................................................................................................done. 23:08:54 INFO - Installing pip.................done. 23:08:54 INFO - Return code: 0 23:08:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:08:54 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')]} 23:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:54 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')]} 23:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:54 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:08:54 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 23:08:54 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 23:08:54 INFO - Using env: {'DISPLAY': ':0', 23:08:54 INFO - 'HOME': '/home/cltbld', 23:08:54 INFO - 'LANG': 'en_US.UTF-8', 23:08:54 INFO - 'LANGUAGE': 'en_US:en', 23:08:54 INFO - 'LOGNAME': 'cltbld', 23:08:54 INFO - 'MAIL': '/var/mail/cltbld', 23:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:54 INFO - 'MOZ_NO_REMOTE': '1', 23:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:54 INFO - 'NO_EM_RESTART': '1', 23:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:54 INFO - 'PWD': '/builds/slave/test', 23:08:54 INFO - 'SHELL': '/bin/bash', 23:08:54 INFO - 'SHLVL': '1', 23:08:54 INFO - 'TERM': 'linux', 23:08:54 INFO - 'TMOUT': '86400', 23:08:54 INFO - 'USER': 'cltbld', 23:08:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:54 INFO - '_': '/tools/buildbot/bin/python'} 23:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:54 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 23:08:54 INFO - Cleaning up... 23:08:54 INFO - Return code: 0 23:08:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:08:54 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')]} 23:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:54 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')]} 23:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:54 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:08:54 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 23:08:54 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 23:08:54 INFO - Using env: {'DISPLAY': ':0', 23:08:54 INFO - 'HOME': '/home/cltbld', 23:08:54 INFO - 'LANG': 'en_US.UTF-8', 23:08:54 INFO - 'LANGUAGE': 'en_US:en', 23:08:54 INFO - 'LOGNAME': 'cltbld', 23:08:54 INFO - 'MAIL': '/var/mail/cltbld', 23:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:54 INFO - 'MOZ_NO_REMOTE': '1', 23:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:54 INFO - 'NO_EM_RESTART': '1', 23:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:54 INFO - 'PWD': '/builds/slave/test', 23:08:54 INFO - 'SHELL': '/bin/bash', 23:08:54 INFO - 'SHLVL': '1', 23:08:54 INFO - 'TERM': 'linux', 23:08:54 INFO - 'TMOUT': '86400', 23:08:54 INFO - 'USER': 'cltbld', 23:08:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:54 INFO - '_': '/tools/buildbot/bin/python'} 23:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:55 INFO - Downloading/unpacking psutil>=3.1.1 23:08:55 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 23:08:55 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 23:08:55 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 23:08:55 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 23:08:55 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 23:08:55 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 23:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:08:57 INFO - Installing collected packages: psutil 23:08:57 INFO - Running setup.py install for psutil 23:08:57 INFO - building 'psutil._psutil_linux' extension 23:08:57 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 23:08:57 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 23:08:57 INFO - building 'psutil._psutil_posix' extension 23:08:57 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 23:08:57 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 23:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:08:57 INFO - Successfully installed psutil 23:08:57 INFO - Cleaning up... 23:08:57 INFO - Return code: 0 23:08:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:08:57 INFO - Using env: {'DISPLAY': ':0', 23:08:57 INFO - 'HOME': '/home/cltbld', 23:08:57 INFO - 'LANG': 'en_US.UTF-8', 23:08:57 INFO - 'LANGUAGE': 'en_US:en', 23:08:57 INFO - 'LOGNAME': 'cltbld', 23:08:57 INFO - 'MAIL': '/var/mail/cltbld', 23:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:57 INFO - 'MOZ_NO_REMOTE': '1', 23:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:57 INFO - 'NO_EM_RESTART': '1', 23:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:57 INFO - 'PWD': '/builds/slave/test', 23:08:57 INFO - 'SHELL': '/bin/bash', 23:08:57 INFO - 'SHLVL': '1', 23:08:57 INFO - 'TERM': 'linux', 23:08:57 INFO - 'TMOUT': '86400', 23:08:57 INFO - 'USER': 'cltbld', 23:08:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:57 INFO - '_': '/tools/buildbot/bin/python'} 23:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:08:59 INFO - Installing collected packages: mozsystemmonitor 23:08:59 INFO - Running setup.py install for mozsystemmonitor 23:08:59 INFO - Successfully installed mozsystemmonitor 23:08:59 INFO - Cleaning up... 23:09:00 INFO - Return code: 0 23:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:09:00 INFO - Using env: {'DISPLAY': ':0', 23:09:00 INFO - 'HOME': '/home/cltbld', 23:09:00 INFO - 'LANG': 'en_US.UTF-8', 23:09:00 INFO - 'LANGUAGE': 'en_US:en', 23:09:00 INFO - 'LOGNAME': 'cltbld', 23:09:00 INFO - 'MAIL': '/var/mail/cltbld', 23:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:00 INFO - 'MOZ_NO_REMOTE': '1', 23:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:00 INFO - 'NO_EM_RESTART': '1', 23:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:00 INFO - 'PWD': '/builds/slave/test', 23:09:00 INFO - 'SHELL': '/bin/bash', 23:09:00 INFO - 'SHLVL': '1', 23:09:00 INFO - 'TERM': 'linux', 23:09:00 INFO - 'TMOUT': '86400', 23:09:00 INFO - 'USER': 'cltbld', 23:09:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:00 INFO - '_': '/tools/buildbot/bin/python'} 23:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - Downloading docopt-0.6.1.tar.gz 23:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:02 INFO - Running setup.py install for blobuploader 23:09:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:02 INFO - Running setup.py install for requests 23:09:03 INFO - Running setup.py install for docopt 23:09:03 INFO - Successfully installed blobuploader requests docopt 23:09:03 INFO - Cleaning up... 23:09:03 INFO - Return code: 0 23:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:03 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')]} 23:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:03 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')]} 23:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:03 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:03 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 23:09:03 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 23:09:03 INFO - Using env: {'DISPLAY': ':0', 23:09:03 INFO - 'HOME': '/home/cltbld', 23:09:03 INFO - 'LANG': 'en_US.UTF-8', 23:09:03 INFO - 'LANGUAGE': 'en_US:en', 23:09:03 INFO - 'LOGNAME': 'cltbld', 23:09:03 INFO - 'MAIL': '/var/mail/cltbld', 23:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:03 INFO - 'MOZ_NO_REMOTE': '1', 23:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:03 INFO - 'NO_EM_RESTART': '1', 23:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:03 INFO - 'PWD': '/builds/slave/test', 23:09:03 INFO - 'SHELL': '/bin/bash', 23:09:03 INFO - 'SHLVL': '1', 23:09:03 INFO - 'TERM': 'linux', 23:09:03 INFO - 'TMOUT': '86400', 23:09:03 INFO - 'USER': 'cltbld', 23:09:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:03 INFO - '_': '/tools/buildbot/bin/python'} 23:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:03 INFO - Running setup.py (path:/tmp/pip-uKBo6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:03 INFO - Running setup.py (path:/tmp/pip-5JRbd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:03 INFO - Running setup.py (path:/tmp/pip-NcPqHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:03 INFO - Running setup.py (path:/tmp/pip-TDmbLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:03 INFO - Running setup.py (path:/tmp/pip-konQNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:03 INFO - Running setup.py (path:/tmp/pip-bpU9OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:04 INFO - Running setup.py (path:/tmp/pip-ZwKckD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:04 INFO - Running setup.py (path:/tmp/pip-D_TguQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:04 INFO - Running setup.py (path:/tmp/pip-hVUzFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:04 INFO - Running setup.py (path:/tmp/pip-MdP_60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:04 INFO - Running setup.py (path:/tmp/pip-WRhayc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:04 INFO - Running setup.py (path:/tmp/pip-lhDWee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:04 INFO - Running setup.py (path:/tmp/pip-hjl8dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:04 INFO - Running setup.py (path:/tmp/pip-xZAWN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:04 INFO - Running setup.py (path:/tmp/pip-TnuFCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:04 INFO - Running setup.py (path:/tmp/pip-CfHpWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:04 INFO - Running setup.py (path:/tmp/pip-U3It1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:04 INFO - Running setup.py install for manifestparser 23:09:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:04 INFO - Running setup.py install for mozcrash 23:09:05 INFO - Running setup.py install for mozdebug 23:09:05 INFO - Running setup.py install for mozdevice 23:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Running setup.py install for mozfile 23:09:05 INFO - Running setup.py install for mozhttpd 23:09:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Running setup.py install for mozinfo 23:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Running setup.py install for mozInstall 23:09:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Running setup.py install for mozleak 23:09:05 INFO - Running setup.py install for mozlog 23:09:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:05 INFO - Running setup.py install for moznetwork 23:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Running setup.py install for mozprocess 23:09:06 INFO - Running setup.py install for mozprofile 23:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Running setup.py install for mozrunner 23:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Running setup.py install for mozscreenshot 23:09:06 INFO - Running setup.py install for moztest 23:09:06 INFO - Running setup.py install for mozversion 23:09:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:06 INFO - Cleaning up... 23:09:06 INFO - Return code: 0 23:09:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:06 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:06 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 23:09:06 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 23:09:06 INFO - Using env: {'DISPLAY': ':0', 23:09:06 INFO - 'HOME': '/home/cltbld', 23:09:06 INFO - 'LANG': 'en_US.UTF-8', 23:09:06 INFO - 'LANGUAGE': 'en_US:en', 23:09:06 INFO - 'LOGNAME': 'cltbld', 23:09:06 INFO - 'MAIL': '/var/mail/cltbld', 23:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:06 INFO - 'MOZ_NO_REMOTE': '1', 23:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:06 INFO - 'NO_EM_RESTART': '1', 23:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:06 INFO - 'PWD': '/builds/slave/test', 23:09:06 INFO - 'SHELL': '/bin/bash', 23:09:06 INFO - 'SHLVL': '1', 23:09:06 INFO - 'TERM': 'linux', 23:09:06 INFO - 'TMOUT': '86400', 23:09:06 INFO - 'USER': 'cltbld', 23:09:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:06 INFO - '_': '/tools/buildbot/bin/python'} 23:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:06 INFO - Running setup.py (path:/tmp/pip-vyZhmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:06 INFO - Running setup.py (path:/tmp/pip-xkeduq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:07 INFO - Running setup.py (path:/tmp/pip-vFOLzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:07 INFO - Running setup.py (path:/tmp/pip-af3ueu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:07 INFO - Running setup.py (path:/tmp/pip-qpFle3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:07 INFO - Running setup.py (path:/tmp/pip-D1EFvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:07 INFO - Running setup.py (path:/tmp/pip-l1d0xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:07 INFO - Running setup.py (path:/tmp/pip-zxJLlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:07 INFO - Running setup.py (path:/tmp/pip-TMHaOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:07 INFO - Running setup.py (path:/tmp/pip-jCv9N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:07 INFO - Running setup.py (path:/tmp/pip-vGTR1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:07 INFO - Running setup.py (path:/tmp/pip-Dc9JFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:07 INFO - Running setup.py (path:/tmp/pip-gloK_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:07 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)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:07 INFO - Running setup.py (path:/tmp/pip-HoGQrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:07 INFO - Running setup.py (path:/tmp/pip-3ZbNzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:08 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)) 23:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:08 INFO - Running setup.py (path:/tmp/pip-mv05aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:08 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)) 23:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:08 INFO - Running setup.py (path:/tmp/pip-ghT6NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:08 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)) 23:09:08 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)) 23:09:08 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)) 23:09:08 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)) 23:09:08 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)) 23:09:08 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)) 23:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:08 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 23:09:08 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 23:09:08 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 23:09:08 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 23:09:08 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 23:09:08 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 23:09:10 INFO - Downloading blessings-1.6.tar.gz 23:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:10 INFO - Installing collected packages: blessings 23:09:10 INFO - Running setup.py install for blessings 23:09:10 INFO - Successfully installed blessings 23:09:10 INFO - Cleaning up... 23:09:10 INFO - Return code: 0 23:09:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:10 INFO - Reading from file tmpfile_stdout 23:09:10 INFO - Current package versions: 23:09:10 INFO - argparse == 1.2.1 23:09:10 INFO - blessings == 1.6 23:09:10 INFO - blobuploader == 1.2.4 23:09:10 INFO - docopt == 0.6.1 23:09:10 INFO - manifestparser == 1.1 23:09:10 INFO - mozInstall == 1.12 23:09:10 INFO - mozcrash == 0.17 23:09:10 INFO - mozdebug == 0.1 23:09:10 INFO - mozdevice == 0.48 23:09:10 INFO - mozfile == 1.2 23:09:10 INFO - mozhttpd == 0.7 23:09:10 INFO - mozinfo == 0.9 23:09:10 INFO - mozleak == 0.1 23:09:10 INFO - mozlog == 3.2 23:09:10 INFO - moznetwork == 0.27 23:09:10 INFO - mozprocess == 0.22 23:09:10 INFO - mozprofile == 0.28 23:09:10 INFO - mozrunner == 6.11 23:09:10 INFO - mozscreenshot == 0.1 23:09:10 INFO - mozsystemmonitor == 0.3 23:09:10 INFO - moztest == 0.7 23:09:10 INFO - mozversion == 1.4 23:09:10 INFO - psutil == 3.1.1 23:09:10 INFO - requests == 1.2.3 23:09:10 INFO - wsgiref == 0.1.2 23:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:10 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')]} 23:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:10 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')]} 23:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:10 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:10 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 23:09:10 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 23:09:10 INFO - Using env: {'DISPLAY': ':0', 23:09:10 INFO - 'HOME': '/home/cltbld', 23:09:10 INFO - 'LANG': 'en_US.UTF-8', 23:09:10 INFO - 'LANGUAGE': 'en_US:en', 23:09:10 INFO - 'LOGNAME': 'cltbld', 23:09:10 INFO - 'MAIL': '/var/mail/cltbld', 23:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:10 INFO - 'MOZ_NO_REMOTE': '1', 23:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:10 INFO - 'NO_EM_RESTART': '1', 23:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:10 INFO - 'PWD': '/builds/slave/test', 23:09:10 INFO - 'SHELL': '/bin/bash', 23:09:10 INFO - 'SHLVL': '1', 23:09:10 INFO - 'TERM': 'linux', 23:09:10 INFO - 'TMOUT': '86400', 23:09:10 INFO - 'USER': 'cltbld', 23:09:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:10 INFO - '_': '/tools/buildbot/bin/python'} 23:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 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)) 23:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:09:10 INFO - Cleaning up... 23:09:10 INFO - Return code: 0 23:09:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:10 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')]} 23:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:10 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')]} 23:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:10 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 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:10 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 23:09:10 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 23:09:10 INFO - Using env: {'DISPLAY': ':0', 23:09:10 INFO - 'HOME': '/home/cltbld', 23:09:10 INFO - 'LANG': 'en_US.UTF-8', 23:09:10 INFO - 'LANGUAGE': 'en_US:en', 23:09:10 INFO - 'LOGNAME': 'cltbld', 23:09:10 INFO - 'MAIL': '/var/mail/cltbld', 23:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:10 INFO - 'MOZ_NO_REMOTE': '1', 23:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:10 INFO - 'NO_EM_RESTART': '1', 23:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:10 INFO - 'PWD': '/builds/slave/test', 23:09:10 INFO - 'SHELL': '/bin/bash', 23:09:10 INFO - 'SHLVL': '1', 23:09:10 INFO - 'TERM': 'linux', 23:09:10 INFO - 'TMOUT': '86400', 23:09:10 INFO - 'USER': 'cltbld', 23:09:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:10 INFO - '_': '/tools/buildbot/bin/python'} 23:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:10 INFO - Downloading/unpacking jsonschema 23:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:12 INFO - Downloading/unpacking functools32 (from jsonschema) 23:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:13 INFO - warning: no files found matching '*.txt' 23:09:13 INFO - no previously-included directories found matching 'build' 23:09:13 INFO - no previously-included directories found matching 'dist' 23:09:13 INFO - no previously-included directories found matching '.git*' 23:09:13 INFO - Installing collected packages: jsonschema, functools32 23:09:13 INFO - Running setup.py install for functools32 23:09:13 INFO - warning: no files found matching '*.txt' 23:09:13 INFO - no previously-included directories found matching 'build' 23:09:13 INFO - no previously-included directories found matching 'dist' 23:09:13 INFO - no previously-included directories found matching '.git*' 23:09:13 INFO - Successfully installed jsonschema functools32 23:09:13 INFO - Cleaning up... 23:09:13 INFO - Return code: 0 23:09:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b56a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1937770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', '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 23:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:09:13 INFO - Using env: {'DISPLAY': ':0', 23:09:13 INFO - 'HOME': '/home/cltbld', 23:09:13 INFO - 'LANG': 'en_US.UTF-8', 23:09:13 INFO - 'LANGUAGE': 'en_US:en', 23:09:13 INFO - 'LOGNAME': 'cltbld', 23:09:13 INFO - 'MAIL': '/var/mail/cltbld', 23:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:13 INFO - 'MOZ_NO_REMOTE': '1', 23:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:13 INFO - 'NO_EM_RESTART': '1', 23:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:13 INFO - 'PWD': '/builds/slave/test', 23:09:13 INFO - 'SHELL': '/bin/bash', 23:09:13 INFO - 'SHLVL': '1', 23:09:13 INFO - 'TERM': 'linux', 23:09:13 INFO - 'TMOUT': '86400', 23:09:13 INFO - 'USER': 'cltbld', 23:09:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:13 INFO - '_': '/tools/buildbot/bin/python'} 23:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:13 INFO - Downloading/unpacking flake8 23:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:09:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:09:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:16 INFO - no previously-included directories found matching 'docs/_build' 23:09:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:09:16 INFO - Running setup.py install for pep8 23:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:16 INFO - no previously-included directories found matching 'docs/_build' 23:09:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:09:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:09:16 INFO - Cleaning up... 23:09:16 INFO - Return code: 0 23:09:16 INFO - Running post-action listener: _resource_record_post_action 23:09:16 INFO - Running post-action listener: _start_resource_monitoring 23:09:16 INFO - Starting resource monitoring. 23:09:16 INFO - ##### 23:09:16 INFO - ##### Finished create-virtualenv step (success) 23:09:16 INFO - ##### 23:09:16 INFO - ##### 23:09:16 INFO - ##### Running install step. 23:09:16 INFO - ##### 23:09:16 INFO - Running pre-action listener: _resource_record_pre_action 23:09:16 INFO - Running main action method: install 23:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:16 INFO - Reading from file tmpfile_stdout 23:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:16 INFO - Reading from file tmpfile_stdout 23:09:16 INFO - Output received: 23:09:16 INFO - Usage: mozinstall [options] installer 23:09:16 INFO - Options: 23:09:16 INFO - -h, --help show this help message and exit 23:09:16 INFO - -d DEST, --destination=DEST 23:09:16 INFO - Directory to install application into. [default: 23:09:16 INFO - "/builds/slave/test"] 23:09:16 INFO - --app=APP Application being installed. [default: firefox] 23:09:16 INFO - mkdir: /builds/slave/test/build/application 23:09:16 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'] 23:09:16 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 23:09:33 INFO - Reading from file tmpfile_stdout 23:09:33 INFO - Output received: 23:09:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:09:33 INFO - Running post-action listener: _resource_record_post_action 23:09:33 INFO - ##### 23:09:33 INFO - ##### Finished install step (success) 23:09:33 INFO - ##### 23:09:33 INFO - ##### 23:09:33 INFO - ##### Running run-tests step. 23:09:33 INFO - ##### 23:09:33 INFO - Running pre-action listener: _resource_record_pre_action 23:09:33 INFO - Running main action method: run_tests 23:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:09:33 INFO - Python 2.7.3 23:09:33 INFO - Return code: 0 23:09:33 INFO - grabbing minidump binary from tooltool 23:09: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')]} 23:09:33 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 0x19c69c0>, '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 0x19c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:09:33 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 23:09:33 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 23:09:33 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 23:09:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:09:33 INFO - Return code: 0 23:09:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:09:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:09:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:09:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:09:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:09:34 INFO - Return code: 0 23:09:34 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/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 23:09:34 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/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 23:09:34 INFO - Using env: {'DISPLAY': ':0', 23:09:34 INFO - 'HOME': '/home/cltbld', 23:09:34 INFO - 'LANG': 'en_US.UTF-8', 23:09:34 INFO - 'LANGUAGE': 'en_US:en', 23:09:34 INFO - 'LOGNAME': 'cltbld', 23:09:34 INFO - 'MAIL': '/var/mail/cltbld', 23:09:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:09:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:34 INFO - 'MOZ_NO_REMOTE': '1', 23:09:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:34 INFO - 'NO_EM_RESTART': '1', 23:09:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:34 INFO - 'PWD': '/builds/slave/test', 23:09:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:09:34 INFO - 'SHELL': '/bin/bash', 23:09:34 INFO - 'SHLVL': '1', 23:09:34 INFO - 'TERM': 'linux', 23:09:34 INFO - 'TMOUT': '86400', 23:09:34 INFO - 'USER': 'cltbld', 23:09:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392', 23:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:34 INFO - '_': '/tools/buildbot/bin/python'} 23:09:34 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/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 23:09:34 INFO - mozversion application_buildid: 20160515203030 23:09:34 INFO - mozversion application_changeset: 7084bd828e4c688daf6078a710d2f267bb52591a 23:09:34 INFO - mozversion application_display_name: Nightly 23:09:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:09:34 INFO - mozversion application_name: Firefox 23:09:34 INFO - mozversion application_remotingname: firefox 23:09:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:09:34 INFO - mozversion application_vendor: Mozilla 23:09:34 INFO - mozversion application_version: 49.0a1 23:09:34 INFO - mozversion platform_buildid: 20160515203030 23:09:34 INFO - mozversion platform_changeset: 7084bd828e4c688daf6078a710d2f267bb52591a 23:09:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:09:34 INFO - mozversion platform_version: 49.0a1 23:09:34 INFO - using testdate: 1463378974 23:09:34 INFO - actual date: 1463378974 23:09:34 INFO - starting webserver on 'localhost:43330' 23:09:34 INFO - SUITE-START | Running 2 tests 23:09:34 INFO - TEST-START | dromaeo_css 23:09:34 INFO - operating with platform_type : linux_ 23:09:34 INFO - Initialising browser for dromaeo_css test... 23:09:34 INFO - TEST-INFO | started process 10012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoaGk3P/profile http://localhost:43330/getInfo.html) 23:09:38 INFO - PROCESS | 10012 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:09:39 INFO - PROCESS | 10012 | __metrics Screen width/height:1600/1200 23:09:39 INFO - PROCESS | 10012 | colorDepth:24 23:09:39 INFO - PROCESS | 10012 | Browser inner width/height: 1024/697 23:09:39 INFO - PROCESS | 10012 | __metrics 23:09:39 ERROR - PROCESS | 10012 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:09:40 INFO - TEST-INFO | 10012: exit 0 23:09:40 INFO - Browser initialized. 23:09:40 INFO - Running cycle 1/1 for dromaeo_css test... 23:09:40 INFO - TEST-INFO | started process 10097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoaGk3P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:09:52 INFO - PROCESS | 10097 | RSS: Main: 152526848 23:09:52 INFO - PROCESS | 10097 | 23:10:44 INFO - PROCESS | 10097 | 1463379044092 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] 23:12:51 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43330/tests/dromaeo/cssquery-ext.html) 23:12:52 INFO - PROCESS | 10097 | RSS: Main: 241868800 23:12:52 INFO - PROCESS | 10097 | 23:15:55 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-ext.html (next: http://localhost:43330/tests/dromaeo/cssquery-jquery.html) 23:15:55 INFO - PROCESS | 10097 | RSS: Main: 239910912 23:15:55 INFO - PROCESS | 10097 | 23:18:57 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43330/tests/dromaeo/cssquery-mootools.html) 23:18:58 INFO - PROCESS | 10097 | RSS: Main: 236351488 23:18:58 INFO - PROCESS | 10097 | 23:22:00 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43330/tests/dromaeo/cssquery-prototype.html) 23:22:00 INFO - PROCESS | 10097 | RSS: Main: 236183552 23:22:00 INFO - PROCESS | 10097 | 23:25:03 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43330/tests/dromaeo/cssquery-yui.html) 23:25:04 INFO - PROCESS | 10097 | RSS: Main: 224862208 23:25:04 INFO - PROCESS | 10097 | 23:28:06 INFO - PROCESS | 10097 | Cycle 1(1): loaded http://localhost:43330/tests/dromaeo/cssquery-yui.html (next: http://localhost:43330/tests/dromaeo/cssquery-dojo.html) 23:28:07 INFO - PROCESS | 10097 | RSS: Main: 280825856 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | __start_tp_report 23:28:07 INFO - PROCESS | 10097 | _x_x_mozilla_page_load 23:28:07 INFO - PROCESS | 10097 | _x_x_mozilla_page_load_details 23:28:07 INFO - PROCESS | 10097 | |i|pagename|runs| 23:28:07 INFO - PROCESS | 10097 | |0;dojo.html;3146.952795708064;3156.3371691944676;3179.3800208959256;3192.425363434581;3219.533167690685;5234.319538460004;5288.709120998344;5333.599980001501;5383.219433182187;5409.350877894653;5304.151335786275;5318.734063296839;5322.787088516455;5362.088444964355;5391.272178255935;4758.881027974302;4847.321375007484;4853.854384368475;4856.271559266103;5067.797288108472;4956.355673762406;5025.195968645017;5031.52200540948;5038.697678139305;5081.6696914700615;4766.8569942901595;4807.951920480786;4864.708117512961;4873.951260487385;4945.307656928033;4822.300766388889;4823;4842.539958703917;4842.58837998767;4967.652264341497;4841.176999909989;4872.902541949176;4873.098476781806;4877.122118018755;4930.013997200538;5152.252923326097;5169.948300516984;5219.869503262449;5230.189320655304;5289.338832645919;5653.689047102408;5671.177679236487;5701.116326969326;5728.05487094633;5735.483806457397;5724.570657200685;5736.541076713853;5738.770449182028;5772.018756811311;5800.651960882361;5248.448912864171;5266.315379000705;5317.627766056377;5321.547668448148;5406.189071639285;5860.912086318709;5892.234009578728;5912;5920;5927.525797936155;5503.889922201533;5653.9151912721345;5698.059820129715;5698.6580805151825;5701.800436984769;5653.462921022497;5774.191613174159;5783.103618939072;5810;5818.7672493100645;5662.292213473316;5717.999350113713;5719.742611582489;5725.370209276976;5726.742296596663;5570.192322113271;5618.85952851182;5655.632383895034;5659.490645841894;5662.631928924607;4355.063661312833;4367.061081867414;4368.104538569649;4379.846705365297;4402.779861007001;3882.398228274622;3887.5140607424073;3903.219356128729;3905.9609403906165;3928.5874983126932;5234.633575649668;5236.450172731808;5320.494553017457;5454.809081682122;5498.120300751861;5719.370869204384;5727.341355744143;5751.539876809845;5759.65442073477;5801.042827933428;5386.811461598903;5403.081476149064;5417.295751552273;5430.266913966643;5444.482774136451;4813.518648135158;4923.8276660316715;4941;4942.135126352874;4992;5912.23140991677;5939.851503712442;5956.285245770535;5959.28488581373;6009.609375390673;5755.309362876482;5771.797987070432;5772.740226689725;5777.3933736957015;5789.102689083199;5711.171880077282;5825.70871456434;5848.005839007294;5883.0293001654245;5931.822045338647;5612.522935550524;5612.7754889803955;5615.775368985358;5616.719164041863;5618.129189975561;5679.9148012779015;5716.485516303553;5723.112917497794;5727.513161381329;5742.397048309867;5429.782808687608;5556.527695145958;5580.525655319343;5617.606767526234;5664.150377443417;5623.8594035149445;5637.43625637433;5641.323041235078;5643.1535269709875;5652.293463317085;5417.6478528895495;5519.061759500814;5556.527695145958;5568.860778480571;5572.777088916398;5514;5567.164925261243;5567.721613919207;5638.5489160867855;5640.746166422603;5457.426970168234;5471.644343117685;5472.124460086367;5473.233747275305;5478.890422191614 23:28:07 INFO - PROCESS | 10097 | |1;ext.html;634.0774173577445;638.2213699286868;641.6791604197902;649.8797722421352;663.847315117523;43743.562564374384;45341.09317813642;45344.999999999956;48726.51273487264;48888;47357;47897;47970.28044579325;47974.52025479744;48002.27996580045;8984.595693193789;9113.68102116426;9114.77213069672;9116.8632470513;9120.908790912106;8955.686550970717;9058.864117038249;9066.365354425192;9073.682421115262;9079.092090790935;9121.863172052424;9172.587233574472;9179.127982841619;9182;9183;8992.415492992934;9023.368364214508;9070.727878163665;9079.727608171732;9082.863757043584;8843.292536597057;8903.599338029804;8905.243054340388;8911.331650126202;8929.508877011762;43786.34320485195;44162.337564936555;44271.557284427065;44284.335734964;44286;3687.668109870098;3777.5089238399105;3799.563050249229;4103.117829666636;4313.8490152844815;32943;33322.666773332196;33341.666583334096;33571;33648.32703345944;4280.721753086071;4285.528591854893;4301.2902871026245;4342.091510424707;4392.209402307583;355941;357524.42475575174;358264;358460;358686.9999999974;50398.49601503938;56835;57476;57575.424245757844;57587;51169.744151279;54770.452295476534;54783.726081369336;62849;63602.68198658977;16332.428365007168;16402.671946561;16464.341426343053;16482.83517164837;16489.6702065958;12130.150889437655;12172.878271217174;12186.146969712212;12194.207376520499;12207.328596927255;15545.30046147926;17339.56651083733;17356.826431735775;17560.91219543894;17567.12164391775;5903.586748927534;5957.942761512886;6036.8188954331445;6046.427928738472;6087.573869829158;977.672479719302;1003.3678782367208;1107.4352080439035;1154.1286328821686;1246.6945598328468;31754.523682144787;32785.50821737676;32863.295359822136;33003;33394.66605333964;1147.9598214062469;1180.9055275577932;1181.4151994762647;1195.862475815275;1229.4590380232669;17393.826061739474;17512.38706645261;17674.469765907044;17680.204390802446;17753.822461775475;519317;522069;522335;523197;525711;57325;57678.711606442535;57735.71132144312;57818.13272800911;58045;1296.6174978381212;1395.0792476965357;1397.1547213935423;1416.0158689710759;1432.298173894805;30360.84819575888;34219.65780342164;34373.70328708911;34536;34966.30067398689;49142.75428622834;59659.70170149121;60595.39404605897;60955.39044609497;61002.084968724615;320689;322976;323978;408438;410457;39179;39816;39865.80067099646;45274.77362613166;46627.53372466232;45923.31115033344;47931.76034119807;50752.23871641854;51540.71148221324;52053.479465204866;42215;43066;43980.78009609931;44152;44998.10003799971;42950;43446.56553434425;43562;43714.34428483512;43919.34120988124;41746.791266043474;43966.780166098964;44997;45128.774356129325;45267.77366113148;37316.440253396766;39167.804160979016;39633;40717.59282407256;40764.59235407608;29720.20456011057;29739.51302434913;29813.25466863259;29862;30317 23:28:07 INFO - PROCESS | 10097 | |2;jquery.html;368.67372375447735;384.81336551772404;387.1173723909487;398.2532751091703;407.71256264333647;17524.123793810322;19000.714989275173;20011.299604513846;20023.899880500594;20047.298344557945;18286.17712202951;18494.16776245069;18761.343352982614;18939.43181704551;19043.333483328086;5445.264889239941;5584.050711379055;5664.0937450008005;5694.2312787773535;5710;5507;5596.608237423382;5612.466815652527;5620.690862002588;5665.603407761459;5373.113436283009;5602.1596760486045;5608.6073974821775;5610.186522954169;5645.830625081234;5667.4615911488345;5667.716614169296;5684.204211410406;5686.2039314496005;5710.628809127415;5325.440828712968;5529.585281103933;5585.664860108406;5597.524210442118;5597.972010139923;12132.150749447454;12235.204711693801;12238.265704057785;12262;12489.687757806038;2269.716285464317;2380.1669415704364;2458.0045081741923;2609.699884513267;2847.288177955511;9007.1893529582;9525.19035881951;9605.90394096057;9665;9895.307328487008;1924.2976313645559;1942.7377304064053;1978.357033963953;2005.8595898287126;2011.386527109231;69470.65264673695;80523;84137.15862841354;84733.57633211794;85987.57006214991;10877.83683244752;10964.28732132409;10979.188433908315;10986.670399888017;11244.55021799119;14112.294385280695;14653.926730366493;14693.55919322422;14806.777898331318;14807.259637018105;7845.725399610987;7936;7981.241782030698;8064.112947575762;8084.919150808534;7545.207753185946;7599.164091949881;7613.733519326908;7654.540727556365;7671.808204794925;4188.308929026676;4280.101178752497;4300.526942036374;4342.261815491374;4409.316555933835;1773.1488885335111;1812.338496448813;1854.4622059602564;1866.7106598477258;1897.3359324236683;404.668172098882;406.37621251378994;409.709106534358;415.96880233982574;1029.8815636201782;10664.733381665521;10727.302725322985;10758.139348852073;10939.83590246147;11111.83332250017;422.4571425717938;427.75617897798577;429.6584215548646;434.07325360355867;445.9687821852504;5744.310682718101;5818.883622327615;5819.418058194146;5849.64902105875;5945.40545945402;494390;500260;509970;510508;513565;70323.29676703167;82443;86351;96186.51906740421;98794;393.7539038101187;400.6254152367546;405.7707395321693;406.6645017860277;408.2691981353344;10212.438315892698;10569.63006294776;10747.785044299226;10751.408672522773;10793.67618971432;37115.44326835153;39126.6087339123;39812;40024;40327.99999999883;55997.16004259858;56907;56977.430225697215;57095;57184;7091.326323999212;8039;8078.838423231385;8208.671653134046;8209;10608.363498189825;13668.111572748137;13728.382222799799;13737.450501980209;13751.174929504261;11260.887391125983;11468.369239691898;11789.351585662871;11974.461149248478;12113.757724845278;11036.227464077438;11224.045956093823;11758.235714678518;11840.407979600814;11864.40677966081;6699.933000670126;10311.432871192157;11358;11397.202195846212;12450.25298482094;7247.528910620793;7305.1599066105955;7386.039814824038;7446.70213191488;7520.473566850268;11067.446627668745;11354.489047992694;11489.942550287195;11565.537378504765;11607.76784464289 23:28:07 INFO - PROCESS | 10097 | |3;mootools.html;1380.9585712428618;1504.5411149599372;1542.3856563125503;1672.7490876368543;1804.9458516244517;8508.702195423153;8808.119188081197;8813.647454101836;9101.544922753868;9110.316726245524;8867.68963086292;9065.501397423139;9069;9079.81840363194;9080.091990800916;1873.8688291819578;2109.5464475137883;2144.5174835662006;2162.805347518723;2224.3882932193615;2194.9231776887814;2196.4508872781803;2203.724534433196;2203.966940495894;2205.547862688153;2064.576761763835;2110.7361579802523;2112.598606264805;2113.968290475644;2115.153938424627;1903.8857668539931;2100.674395468697;2138.893055347242;2145.3778404262744;2148.967765483519;2049.8975051247526;2054.794520547933;2055.2292890166186;2056.969145462819;2073.170731707314;8664.176903194186;8789.384743067987;8789.604467798901;8798;8798.164174403422;5128.692278463304;5247.212918062283;5253.238280449314;5258.526732594047;5260.736963151827;3254.576905002358;3329.70032697056;3344.866205351783;3347.7656564040526;3402.387570237356;1064.7178497698117;1071.7588542577935;1074.6722249713835;1081.3565928272665;1151.2657438583365;13016.674583135402;13031.934840325832;13042.543510977164;13058.2817945013;13068.738625227537;4480.193565158238;4512.616427603625;4552.317152427162;4587.931181032287;4609.608183304456;10874.075703565128;10874.67375978722;10899.29154604948;10913.508892099875;10918.12654987615;4711.976440117777;5224.555912747383;5229.843104706865;5252.9737351313;5270.209468579744;4389.056352884145;4452.777361131995;4675.602573781199;4766.928496072562;4803.95196048042;3921.9803900980314;3973.2252210818615;4046.393041043867;4064.9796751016056;4094.836206551764;1180.144395313408;1194.8864857838491;1196.5333519927235;1215.0583297943988;1223.902087832989;923.6259314977444;1021.7190272675074;1039.4023436524028;1055.9577616895392;1064.3932958213743;6288.339724328971;6393.872122557523;6475.190601174853;6501.772437964649;6538.673066346663;405.126951419691;409.38387726472064;411.30900087852694;412.67811107336325;415.1261594343923;4328.523862375137;4442.244818380883;4498.59512643857;4545.522720114341;4551.52209018055;10922.508487118099;11326.773464530663;11349.489272982735;11363.829542556869;11376.715582110348;10764;11186;11203.383813890152;11483.25358851672;11496.827547586792;8381.203785640355;8443.95778021106;8609.397342185986;8663;8663.350248731243;6240.53196010292;6258.812235632939;6382.393672601095;6390.105385246162;6460.45086167681;10184.847227291448;10674.57301707923;10741.227697429837;10766.676999690022;10797.62208322705;10475.266731328733;10766.515506802056;10775.622853200413;10821.51303191374;10829.783404332027;7059.717611295696;7782.299593036654;8013.278804907586;8052.5571093590415;8190.590470476333;8777.473351598925;8808.163224493663;8837.072107428885;8884.422512536665;8893.688720894737;7659.119201291923;8001;8179.591020449073;8189.262966333059;8383.53890536002;7992.240737129963;8207.097219305751;8281.627326770189;8304.418690691593;8315.501069935823;6858;7083.610401427971;7096.858062838817;7177.641117943977;7250.528715633467;5178.689278643294;5468.152436372368;5477.917831232455;5537.224788529689;5555.666660000413;5660.066089095253;5674.517665998436;5679.574031947703;5726.370099289158;5726.685032323262 23:28:07 INFO - PROCESS | 10097 | |4;prototype.html;308.40323973112027;309.34419031652897;311.93449375631116;315.1082436704128;316.1732070635288;5222.138347172717;5278.815241466549;5287.312649355588;5302.549283310923;5355.410904800468;5247.186686063656;5256.369235691713;5263.236830659552;5280.204730391666;5337.733113344337;3946.506686664167;3967.444557761916;4083.4691490106243;4086.795660216992;4114.8971275718195;4044.5550989391145;4068.6338229559333;4076.449679293302;4086.2440448516973;4105.035316700573;3953.8138558432497;4024.879253622396;4034.677225821942;4039.131586708857;4062.3906414037833;3969.126792105732;4028.7582745035247;4054.506478515721;4058.8782336529953;4083.4283200351974;3580.087077795172;3589.8025608591515;3596.5684117906017;3599.3521166190076;3620.637936206358;5061.190209566452;5080.542751152377;5089.898202035975;5104.617153713486;5111.693298402108;4552.884543286883;4658.021815418766;4668.533146685339;4671.836485723017;4693.976530117362;5460.918086228709;5485.945140548583;5558;5566.165075238706;5581.832545023656;3982.123932734794;3995.640392364672;4000.5399379071487;4010.2581022510635;4013.3779264214095;5590.651926190969;5648.096304591246;5660.716964151776;5689.544836413118;5698.951061182289;4006.899827504336;4011.5988401159652;4036.990752311922;4037.313656678372;4040.898977525527;4089.6523795477124;4121.175764847043;4123.8969025774595;4151.667866570667;4151.73013754105;4578.0157266187925;4579.22153233951;4612.238980568236;4649.511801260819;4752.334673145762;5444.393903798389;5453;5474.7262636868;5525.4474552544425;5576.135698966586;1404.7401230772339;1426.165693069566;1433.6129245103764;1434.823444775295;1443.8449240607472;901.985266575103;915.2266334946959;949.9097585729345;950.2398081534883;952.8570714392896;5207.270982062514;5238.60710446718;5239.842804715865;5272.657277276965;5284.445133260952;5574.526165275997;5583.832485025456;5596.608237423341;5620.831375058755;5622.915656265078;5008.974955125201;5229.686218826882;5261;5289.576833853283;5317.500774635915;2971.7919745618033;2974.3456439583256;2977.791554591201;3002.288695443576;3017.230606195406;5710.914336284959;5726.024521540062;5733.598648094593;5762.193292938992;5767.336756272998;5483.396826349099;5757.88484230313;5783.033768518724;5794.768209271582;5875.324337701134;5850.444207800252;5873.882522349529;5879.147523609053;5898.3216930053595;5923.7926672566255;5579.69311687861;5697.914531282117;5703.543716502752;5746.569007324384;5750.367459579359;5607.775688972395;5646.745896434588;5653.208550802973;5662.490375866192;5664.320281566238;5884.7940322090235;5889.587728858939;5889.732453005709;5909.6158749681135;5920.579061025237;3732.197577520846;3931.8034098294397;3955.6044395560216;3958.584348643351;3961.1681546874324;5539.972300138474;5581.944180558143;5639.943600563942;5648.322201335702;5674.57440691958;5323.441038691037;5367.382750983531;5552.555795536428;5555.472230138131;5560.082586373203;5528.695921724344;5533.253010843646;5533.438893911593;5536.833894983157;5567.9977604031665;5225.973870130625;5409.918851217313;5420.9186862197885;5457.754401051883;5463.562914966873;5557.749901254372;5587.74855131512;5605.243292155506;5612.484629150025;5613.438656134354;5382.811601593926;5445.591580631548;5485.149801780731;5491.615586909038;5501 23:28:07 INFO - PROCESS | 10097 | |5;yui.html;713.140307367457;740.389178927385;747.0251322024759;760.3157158557299;784.9097353804312;14346.497872574462;15991.520254392371;16438.589035274123;16484.258208380623;17069.40257091002;14826;15082.245887705625;15263.694726105472;15366.462173823918;15399.615009624737;689.5655736885755;799.4683535448919;835.7158566087529;843.3421930893912;843.8818565400849;838.6100463284572;844.3540691371076;844.586152785137;844.5945945945949;849.0660273698912;868.6872725818732;879.6437442835662;883.5670521444478;883.9911600883974;884.0099089020306;728.6283995162479;854.679495189304;874.5190145420057;875.7591662292889;876.8027193881389;621.6425555305672;622.017212803769;622.4553515673786;622.5362105231632;623.9251289845203;14801.851981480155;14830.555083347517;14832.332545035499;14861.554153375417;14861.851381486264;13246.66883327915;13538.864611353958;13644.454221831114;13660.931695341558;13884.4446222151;12008.939955300255;12270.877291227063;12280.078994075391;12369.381530923507;12395.318257495834;4503.301988191803;4546;4597.126545956257;4684.718916864999;4717.622590192776;59000.11499827506;59396.70301648507;59515;59671.70164149195;60219;10883.85538351884;10929.508172132273;10943.507542160622;10963.50664220112;11186.608468703556;18001.7299740504;18024.36914708005;18037.27850885976;18047.458576242734;18071.909640451977;8586.699465518677;8752.824943501222;8834.249088827393;8937.240334571505;9017.819643607223;4852.223644216909;4875.390576177978;4975.278584605212;5078.898422031539;5138.58891288696;3509.2279698466295;3612;3632.600413954463;3634.454831775202;3638.326909521747;689.9448044156455;724.5435375713372;726.4333819620705;744.244591739385;747.1818358896999;763.9312461878458;781.8279978404742;782.6908371193347;784.7645706288091;817.8977627796526;9207.447553146832;9437.528123593793;9738.659146929824;9764.609415623438;9943.502824858728;737.6459299536252;741.2735519191223;765.016953215127;804.9839003219903;815.6085079162035;4458.420405347284;4487.573680500347;4635.837745678885;4718.504557021532;4778.450478194983;71801.6409917947;76998;77044.3643593886;77912;78086.6095669518;63667.36332636707;64837.67581162064;65468.34531654623;67167;67410.32589674139;56876.43123568794;59142;59348.7032564843;60081.699591502635;60175.699121504986;9380.249580033444;9398.34211605181;9408.576614052246;9470.621175152917;9523.857142143012;38996.415053774785;40368;40570.18859622732;40607.3908891361;41349.79325103355;50721.492785073155;54750.726246370104;54927.45072549383;55276.44723552713;56021.71989140028;11665.183437159318;11841.46713397882;12349.567765128177;12761.553345632858;12774.68063298425;14162.78755818643;14201.289935502977;14235.64410889736;14248.786268206193;15042;13742;13750.587482375544;13862.098963567336;14065.648358791112;14839;12286.87713122893;13162.60512184636;13171.60485185446;13446.394912229169;13788.172709637454;13101.863416096241;13315.933420332836;13686.110402823784;14102.153870767786;14207.715845683235;10956.835647465454;11297;11308.321500709984;11471.541138354372;12048.698782530508;11254.606088786853;11412.828807567726;11417.657470275904;11559.248648837798;11606.187566870238 23:28:07 INFO - PROCESS | 10097 | __end_tp_report 23:28:07 INFO - PROCESS | 10097 | __start_cc_report 23:28:07 INFO - PROCESS | 10097 | _x_x_mozilla_cycle_collect,847 23:28:07 INFO - PROCESS | 10097 | __end_cc_report 23:28:07 INFO - PROCESS | 10097 | __startTimestamp1463380087004__endTimestamp 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | ------- Summary: start ------- 23:28:07 INFO - PROCESS | 10097 | Number of tests: 6 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#0] dojo.html Cycles:165 Average:5314.99 Median:5503.89 stddev:592.18 (10.8%) stddev-sans-first:569.05 23:28:07 INFO - PROCESS | 10097 | Values: 3147.0 3156.3 3179.4 3192.4 3219.5 5234.3 5288.7 5333.6 5383.2 5409.4 5304.2 5318.7 5322.8 5362.1 5391.3 4758.9 4847.3 4853.9 4856.3 5067.8 4956.4 5025.2 5031.5 5038.7 5081.7 4766.9 4808.0 4864.7 4874.0 4945.3 4822.3 4823.0 4842.5 4842.6 4967.7 4841.2 4872.9 4873.1 4877.1 4930.0 5152.3 5169.9 5219.9 5230.2 5289.3 5653.7 5671.2 5701.1 5728.1 5735.5 5724.6 5736.5 5738.8 5772.0 5800.7 5248.4 5266.3 5317.6 5321.5 5406.2 5860.9 5892.2 5912.0 5920.0 5927.5 5503.9 5653.9 5698.1 5698.7 5701.8 5653.5 5774.2 5783.1 5810.0 5818.8 5662.3 5718.0 5719.7 5725.4 5726.7 5570.2 5618.9 5655.6 5659.5 5662.6 4355.1 4367.1 4368.1 4379.8 4402.8 3882.4 3887.5 3903.2 3906.0 3928.6 5234.6 5236.5 5320.5 5454.8 5498.1 5719.4 5727.3 5751.5 5759.7 5801.0 5386.8 5403.1 5417.3 5430.3 5444.5 4813.5 4923.8 4941.0 4942.1 4992.0 5912.2 5939.9 5956.3 5959.3 6009.6 5755.3 5771.8 5772.7 5777.4 5789.1 5711.2 5825.7 5848.0 5883.0 5931.8 5612.5 5612.8 5615.8 5616.7 5618.1 5679.9 5716.5 5723.1 5727.5 5742.4 5429.8 5556.5 5580.5 5617.6 5664.2 5623.9 5637.4 5641.3 5643.2 5652.3 5417.6 5519.1 5556.5 5568.9 5572.8 5514.0 5567.2 5567.7 5638.5 5640.7 5457.4 5471.6 5472.1 5473.2 5478.9 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#1] ext.html Cycles:180 Average:59027.30 Median:24155.78 stddev:111114.81 (460.0%) stddev-sans-first:111340.02 23:28:07 INFO - PROCESS | 10097 | Values: 634.1 638.2 641.7 649.9 663.8 43743.6 45341.1 45345.0 48726.5 48888.0 47357.0 47897.0 47970.3 47974.5 48002.3 8984.6 9113.7 9114.8 9116.9 9120.9 8955.7 9058.9 9066.4 9073.7 9079.1 9121.9 9172.6 9179.1 9182.0 9183.0 8992.4 9023.4 9070.7 9079.7 9082.9 8843.3 8903.6 8905.2 8911.3 8929.5 43786.3 44162.3 44271.6 44284.3 44286.0 3687.7 3777.5 3799.6 4103.1 4313.8 32943.0 33322.7 33341.7 33571.0 33648.3 4280.7 4285.5 4301.3 4342.1 4392.2 355941.0 357524.4 358264.0 358460.0 358687.0 50398.5 56835.0 57476.0 57575.4 57587.0 51169.7 54770.5 54783.7 62849.0 63602.7 16332.4 16402.7 16464.3 16482.8 16489.7 12130.2 12172.9 12186.1 12194.2 12207.3 15545.3 17339.6 17356.8 17560.9 17567.1 5903.6 5957.9 6036.8 6046.4 6087.6 977.7 1003.4 1107.4 1154.1 1246.7 31754.5 32785.5 32863.3 33003.0 33394.7 1148.0 1180.9 1181.4 1195.9 1229.5 17393.8 17512.4 17674.5 17680.2 17753.8 519317.0 522069.0 522335.0 523197.0 525711.0 57325.0 57678.7 57735.7 57818.1 58045.0 1296.6 1395.1 1397.2 1416.0 1432.3 30360.8 34219.7 34373.7 34536.0 34966.3 49142.8 59659.7 60595.4 60955.4 61002.1 320689.0 322976.0 323978.0 408438.0 410457.0 39179.0 39816.0 39865.8 45274.8 46627.5 45923.3 47931.8 50752.2 51540.7 52053.5 42215.0 43066.0 43980.8 44152.0 44998.1 42950.0 43446.6 43562.0 43714.3 43919.3 41746.8 43966.8 44997.0 45128.8 45267.8 37316.4 39167.8 39633.0 40717.6 40764.6 29720.2 29739.5 29813.3 29862.0 30317.0 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#2] jquery.html Cycles:180 Average:28108.70 Median:407.99 stddev:83410.36 (20444.2%) stddev-sans-first:83618.34 23:28:07 INFO - PROCESS | 10097 | Values: 368.7 384.8 387.1 398.3 407.7 17524.1 19000.7 20011.3 20023.9 20047.3 18286.2 18494.2 18761.3 18939.4 19043.3 5445.3 5584.1 5664.1 5694.2 5710.0 5507.0 5596.6 5612.5 5620.7 5665.6 5373.1 5602.2 5608.6 5610.2 5645.8 5667.5 5667.7 5684.2 5686.2 5710.6 5325.4 5529.6 5585.7 5597.5 5598.0 12132.2 12235.2 12238.3 12262.0 12489.7 2269.7 2380.2 2458.0 2609.7 2847.3 9007.2 9525.2 9605.9 9665.0 9895.3 1924.3 1942.7 1978.4 2005.9 2011.4 69470.7 80523.0 84137.2 84733.6 85987.6 10877.8 10964.3 10979.2 10986.7 11244.6 14112.3 14653.9 14693.6 14806.8 14807.3 7845.7 7936.0 7981.2 8064.1 8084.9 7545.2 7599.2 7613.7 7654.5 7671.8 4188.3 4280.1 4300.5 4342.3 4409.3 1773.1 1812.3 1854.5 1866.7 1897.3 404.7 406.4 409.7 416.0 1029.9 10664.7 10727.3 10758.1 10939.8 11111.8 422.5 427.8 429.7 434.1 446.0 5744.3 5818.9 5819.4 5849.6 5945.4 494390.0 500260.0 509970.0 510508.0 513565.0 70323.3 82443.0 86351.0 96186.5 98794.0 393.8 400.6 405.8 406.7 408.3 10212.4 10569.6 10747.8 10751.4 10793.7 37115.4 39126.6 39812.0 40024.0 40328.0 55997.2 56907.0 56977.4 57095.0 57184.0 7091.3 8039.0 8078.8 8208.7 8209.0 10608.4 13668.1 13728.4 13737.5 13751.2 11260.9 11468.4 11789.4 11974.5 12113.8 11036.2 11224.0 11758.2 11840.4 11864.4 6699.9 10311.4 11358.0 11397.2 12450.3 7247.5 7305.2 7386.0 7446.7 7520.5 11067.4 11354.5 11489.9 11565.5 11607.8 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#3] mootools.html Cycles:180 Average:5950.57 Median:4415.65 stddev:3522.92 (79.8%) stddev-sans-first:3516.07 23:28:07 INFO - PROCESS | 10097 | Values: 1381.0 1504.5 1542.4 1672.7 1804.9 8508.7 8808.1 8813.6 9101.5 9110.3 8867.7 9065.5 9069.0 9079.8 9080.1 1873.9 2109.5 2144.5 2162.8 2224.4 2194.9 2196.5 2203.7 2204.0 2205.5 2064.6 2110.7 2112.6 2114.0 2115.2 1903.9 2100.7 2138.9 2145.4 2149.0 2049.9 2054.8 2055.2 2057.0 2073.2 8664.2 8789.4 8789.6 8798.0 8798.2 5128.7 5247.2 5253.2 5258.5 5260.7 3254.6 3329.7 3344.9 3347.8 3402.4 1064.7 1071.8 1074.7 1081.4 1151.3 13016.7 13031.9 13042.5 13058.3 13068.7 4480.2 4512.6 4552.3 4587.9 4609.6 10874.1 10874.7 10899.3 10913.5 10918.1 4712.0 5224.6 5229.8 5253.0 5270.2 4389.1 4452.8 4675.6 4766.9 4804.0 3922.0 3973.2 4046.4 4065.0 4094.8 1180.1 1194.9 1196.5 1215.1 1223.9 923.6 1021.7 1039.4 1056.0 1064.4 6288.3 6393.9 6475.2 6501.8 6538.7 405.1 409.4 411.3 412.7 415.1 4328.5 4442.2 4498.6 4545.5 4551.5 10922.5 11326.8 11349.5 11363.8 11376.7 10764.0 11186.0 11203.4 11483.3 11496.8 8381.2 8444.0 8609.4 8663.0 8663.4 6240.5 6258.8 6382.4 6390.1 6460.5 10184.8 10674.6 10741.2 10766.7 10797.6 10475.3 10766.5 10775.6 10821.5 10829.8 7059.7 7782.3 8013.3 8052.6 8190.6 8777.5 8808.2 8837.1 8884.4 8893.7 7659.1 8001.0 8179.6 8189.3 8383.5 7992.2 8207.1 8281.6 8304.4 8315.5 6858.0 7083.6 7096.9 7177.6 7250.5 5178.7 5468.2 5477.9 5537.2 5555.7 5660.1 5674.5 5679.6 5726.4 5726.7 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#4] prototype.html Cycles:180 Average:4635.54 Median:5288.44 stddev:1370.08 (25.9%) stddev-sans-first:1334.88 23:28:07 INFO - PROCESS | 10097 | Values: 308.4 309.3 311.9 315.1 316.2 5222.1 5278.8 5287.3 5302.5 5355.4 5247.2 5256.4 5263.2 5280.2 5337.7 3946.5 3967.4 4083.5 4086.8 4114.9 4044.6 4068.6 4076.4 4086.2 4105.0 3953.8 4024.9 4034.7 4039.1 4062.4 3969.1 4028.8 4054.5 4058.9 4083.4 3580.1 3589.8 3596.6 3599.4 3620.6 5061.2 5080.5 5089.9 5104.6 5111.7 4552.9 4658.0 4668.5 4671.8 4694.0 5460.9 5485.9 5558.0 5566.2 5581.8 3982.1 3995.6 4000.5 4010.3 4013.4 5590.7 5648.1 5660.7 5689.5 5699.0 4006.9 4011.6 4037.0 4037.3 4040.9 4089.7 4121.2 4123.9 4151.7 4151.7 4578.0 4579.2 4612.2 4649.5 4752.3 5444.4 5453.0 5474.7 5525.4 5576.1 1404.7 1426.2 1433.6 1434.8 1443.8 902.0 915.2 949.9 950.2 952.9 5207.3 5238.6 5239.8 5272.7 5284.4 5574.5 5583.8 5596.6 5620.8 5622.9 5009.0 5229.7 5261.0 5289.6 5317.5 2971.8 2974.3 2977.8 3002.3 3017.2 5710.9 5726.0 5733.6 5762.2 5767.3 5483.4 5757.9 5783.0 5794.8 5875.3 5850.4 5873.9 5879.1 5898.3 5923.8 5579.7 5697.9 5703.5 5746.6 5750.4 5607.8 5646.7 5653.2 5662.5 5664.3 5884.8 5889.6 5889.7 5909.6 5920.6 3732.2 3931.8 3955.6 3958.6 3961.2 5540.0 5581.9 5639.9 5648.3 5674.6 5323.4 5367.4 5552.6 5555.5 5560.1 5528.7 5533.3 5533.4 5536.8 5568.0 5226.0 5409.9 5420.9 5457.8 5463.6 5557.7 5587.7 5605.2 5612.5 5613.4 5382.8 5445.6 5485.1 5491.6 5501.0 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - PROCESS | 10097 | [#5] yui.html Cycles:180 Average:16655.60 Median:4863.81 stddev:20344.41 (418.3%) stddev-sans-first:20366.26 23:28:07 INFO - PROCESS | 10097 | Values: 713.1 740.4 747.0 760.3 784.9 14346.5 15991.5 16438.6 16484.3 17069.4 14826.0 15082.2 15263.7 15366.5 15399.6 689.6 799.5 835.7 843.3 843.9 838.6 844.4 844.6 844.6 849.1 868.7 879.6 883.6 884.0 884.0 728.6 854.7 874.5 875.8 876.8 621.6 622.0 622.5 622.5 623.9 14801.9 14830.6 14832.3 14861.6 14861.9 13246.7 13538.9 13644.5 13660.9 13884.4 12008.9 12270.9 12280.1 12369.4 12395.3 4503.3 4546.0 4597.1 4684.7 4717.6 59000.1 59396.7 59515.0 59671.7 60219.0 10883.9 10929.5 10943.5 10963.5 11186.6 18001.7 18024.4 18037.3 18047.5 18071.9 8586.7 8752.8 8834.2 8937.2 9017.8 4852.2 4875.4 4975.3 5078.9 5138.6 3509.2 3612.0 3632.6 3634.5 3638.3 689.9 724.5 726.4 744.2 747.2 763.9 781.8 782.7 784.8 817.9 9207.4 9437.5 9738.7 9764.6 9943.5 737.6 741.3 765.0 805.0 815.6 4458.4 4487.6 4635.8 4718.5 4778.5 71801.6 76998.0 77044.4 77912.0 78086.6 63667.4 64837.7 65468.3 67167.0 67410.3 56876.4 59142.0 59348.7 60081.7 60175.7 9380.2 9398.3 9408.6 9470.6 9523.9 38996.4 40368.0 40570.2 40607.4 41349.8 50721.5 54750.7 54927.5 55276.4 56021.7 11665.2 11841.5 12349.6 12761.6 12774.7 14162.8 14201.3 14235.6 14248.8 15042.0 13742.0 13750.6 13862.1 14065.6 14839.0 12286.9 13162.6 13171.6 13446.4 13788.2 13101.9 13315.9 13686.1 14102.2 14207.7 10956.8 11297.0 11308.3 11471.5 12048.7 11254.6 11412.8 11417.7 11559.2 11606.2 23:28:07 INFO - PROCESS | 10097 | -------- Summary: end -------- 23:28:07 INFO - PROCESS | 10097 | 23:28:07 INFO - TEST-INFO | 10097: exit 0 23:28:07 INFO - TEST-OK | dromaeo_css | took 1113211ms 23:28:07 INFO - TEST-START | kraken 23:28:07 INFO - operating with platform_type : linux_ 23:28:07 INFO - Initialising browser for kraken test... 23:28:07 INFO - TEST-INFO | started process 10284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWQ_0T/profile http://localhost:43330/getInfo.html) 23:28:11 INFO - PROCESS | 10284 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:28:11 INFO - PROCESS | 10284 | __metrics Screen width/height:1600/1200 23:28:11 INFO - PROCESS | 10284 | colorDepth:24 23:28:11 INFO - PROCESS | 10284 | Browser inner width/height: 1024/697 23:28:11 INFO - PROCESS | 10284 | __metrics 23:28:12 ERROR - PROCESS | 10284 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:28:13 INFO - TEST-INFO | 10284: exit 0 23:28:13 INFO - Browser initialized. 23:28:13 INFO - Running cycle 1/1 for kraken test... 23:28:13 INFO - TEST-INFO | started process 10363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWQ_0T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:25 INFO - PROCESS | 10363 | RSS: Main: 152690688 23:28:25 INFO - PROCESS | 10363 | 23:28:28 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43330/tests/kraken/driver.html?testName=audio-beat-detection) 23:28:28 INFO - PROCESS | 10363 | RSS: Main: 208650240 23:28:28 INFO - PROCESS | 10363 | 23:28:31 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43330/tests/kraken/driver.html?testName=audio-dft) 23:28:32 INFO - PROCESS | 10363 | RSS: Main: 198557696 23:28:32 INFO - PROCESS | 10363 | 23:28:35 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43330/tests/kraken/driver.html?testName=audio-fft) 23:28:36 INFO - PROCESS | 10363 | RSS: Main: 265596928 23:28:36 INFO - PROCESS | 10363 | 23:28:38 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43330/tests/kraken/driver.html?testName=audio-oscillator) 23:28:38 INFO - PROCESS | 10363 | RSS: Main: 174731264 23:28:38 INFO - PROCESS | 10363 | 23:28:41 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:28:41 INFO - PROCESS | 10363 | RSS: Main: 178675712 23:28:41 INFO - PROCESS | 10363 | 23:28:44 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43330/tests/kraken/driver.html?testName=imaging-darkroom) 23:28:45 INFO - PROCESS | 10363 | RSS: Main: 214401024 23:28:45 INFO - PROCESS | 10363 | 23:28:49 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43330/tests/kraken/driver.html?testName=imaging-desaturate) 23:28:49 INFO - PROCESS | 10363 | RSS: Main: 212787200 23:28:49 INFO - PROCESS | 10363 | 23:28:52 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43330/tests/kraken/driver.html?testName=json-parse-financial) 23:28:53 INFO - PROCESS | 10363 | RSS: Main: 214155264 23:28:53 INFO - PROCESS | 10363 | 23:28:54 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:28:55 INFO - PROCESS | 10363 | RSS: Main: 204644352 23:28:55 INFO - PROCESS | 10363 | 23:28:57 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:28:57 INFO - PROCESS | 10363 | RSS: Main: 208408576 23:28:57 INFO - PROCESS | 10363 | 23:28:59 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:00 INFO - PROCESS | 10363 | RSS: Main: 218198016 23:29:00 INFO - PROCESS | 10363 | 23:29:03 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:03 INFO - PROCESS | 10363 | RSS: Main: 223739904 23:29:03 INFO - PROCESS | 10363 | 23:29:06 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:07 INFO - PROCESS | 10363 | RSS: Main: 218730496 23:29:07 INFO - PROCESS | 10363 | 23:29:08 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:43330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43330/tests/kraken/driver.html?testName=ai-astar) 23:29:09 INFO - PROCESS | 10363 | RSS: Main: 264753152 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | __start_tp_report 23:29:09 INFO - PROCESS | 10363 | _x_x_mozilla_page_load 23:29:09 INFO - PROCESS | 10363 | _x_x_mozilla_page_load_details 23:29:09 INFO - PROCESS | 10363 | |i|pagename|runs| 23:29:09 INFO - PROCESS | 10363 | |0;ai-astar;111;105;111;109;109;110;110;111;109;112 23:29:09 INFO - PROCESS | 10363 | |1;audio-beat-detection;146;123;153;207;122;152;154;124;179;125 23:29:09 INFO - PROCESS | 10363 | |2;audio-dft;161;161;161;160;162;160;162;161;160;161 23:29:09 INFO - PROCESS | 10363 | |3;audio-fft;74;74;76;150;77;75;76;75;132;76 23:29:09 INFO - PROCESS | 10363 | |4;audio-oscillator;91;92;157;92;92;92;136;91;91;116 23:29:09 INFO - PROCESS | 10363 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 23:29:09 INFO - PROCESS | 10363 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 23:29:09 INFO - PROCESS | 10363 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 23:29:09 INFO - PROCESS | 10363 | |8;json-parse-financial;54;54;55;53;55;54;55;106;52;54 23:29:09 INFO - PROCESS | 10363 | |9;json-stringify-tinderbox;59;59;58;58;58;58;59;59;58;59 23:29:09 INFO - PROCESS | 10363 | |10;stanford-crypto-aes;78;78;78;78;83;82;78;79;86;81 23:29:09 INFO - PROCESS | 10363 | |11;stanford-crypto-ccm;121;122;121;126;133;123;116;117;199;122 23:29:09 INFO - PROCESS | 10363 | |12;stanford-crypto-pbkdf2;161;162;159;162;158;157;157;157;164;161 23:29:09 INFO - PROCESS | 10363 | |13;stanford-crypto-sha256-iterative;62;63;63;62;65;64;62;63;61;64 23:29:09 INFO - PROCESS | 10363 | __end_tp_report 23:29:09 INFO - PROCESS | 10363 | __start_cc_report 23:29:09 INFO - PROCESS | 10363 | _x_x_mozilla_cycle_collect,1880 23:29:09 INFO - PROCESS | 10363 | __end_cc_report 23:29:09 INFO - PROCESS | 10363 | __startTimestamp1463380149235__endTimestamp 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | ------- Summary: start ------- 23:29:09 INFO - PROCESS | 10363 | Number of tests: 14 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.95 (1.8%) stddev-sans-first:2.01 23:29:09 INFO - PROCESS | 10363 | Values: 111.0 105.0 111.0 109.0 109.0 110.0 110.0 111.0 109.0 112.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:152.50 stddev:27.74 (18.2%) stddev-sans-first:29.41 23:29:09 INFO - PROCESS | 10363 | Values: 146.0 123.0 153.0 207.0 122.0 152.0 154.0 124.0 179.0 125.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:29:09 INFO - PROCESS | 10363 | Values: 161.0 161.0 161.0 160.0 162.0 160.0 162.0 161.0 160.0 161.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.50 stddev:28.01 (37.1%) stddev-sans-first:29.21 23:29:09 INFO - PROCESS | 10363 | Values: 74.0 74.0 76.0 150.0 77.0 75.0 76.0 75.0 132.0 76.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:91.50 stddev:23.69 (25.9%) stddev-sans-first:24.58 23:29:09 INFO - PROCESS | 10363 | Values: 91.0 92.0 157.0 92.0 92.0 92.0 136.0 91.0 91.0 116.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:29:09 INFO - PROCESS | 10363 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:29:09 INFO - PROCESS | 10363 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:29:09 INFO - PROCESS | 10363 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:54.00 stddev:16.47 (30.5%) stddev-sans-first:17.36 23:29:09 INFO - PROCESS | 10363 | Values: 54.0 54.0 55.0 53.0 55.0 54.0 55.0 106.0 52.0 54.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:29:09 INFO - PROCESS | 10363 | Values: 59.0 59.0 58.0 58.0 58.0 58.0 59.0 59.0 58.0 59.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.81 (3.5%) stddev-sans-first:2.87 23:29:09 INFO - PROCESS | 10363 | Values: 78.0 78.0 78.0 78.0 83.0 82.0 78.0 79.0 86.0 81.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:122.50 stddev:24.70 (20.2%) stddev-sans-first:25.98 23:29:09 INFO - PROCESS | 10363 | Values: 121.0 122.0 121.0 126.0 133.0 123.0 116.0 117.0 199.0 122.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:161.00 stddev:2.53 (1.6%) stddev-sans-first:2.65 23:29:09 INFO - PROCESS | 10363 | Values: 161.0 162.0 159.0 162.0 158.0 157.0 157.0 157.0 164.0 161.0 23:29:09 INFO - PROCESS | 10363 | 23:29:09 INFO - PROCESS | 10363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.22 23:29:09 INFO - PROCESS | 10363 | Values: 62.0 63.0 63.0 62.0 65.0 64.0 62.0 63.0 61.0 64.0 23:29:09 INFO - PROCESS | 10363 | -------- Summary: end -------- 23:29:09 INFO - PROCESS | 10363 | 23:29:10 INFO - TEST-INFO | 10363: exit 0 23:29:10 INFO - TEST-OK | kraken | took 62510ms 23:29:10 INFO - SUITE-END | took 1175s 23:29:10 INFO - Completed test suite (00:19:35) 23:29:10 INFO - javascript benchmark 23:29:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.952795708064, 3156.3371691944676, 3179.3800208959256, 3192.425363434581, 3219.533167690685, 5234.319538460004, 5288.709120998344, 5333.599980001501, 5383.219433182187, 5409.350877894653, 5304.151335786275, 5318.734063296839, 5322.787088516455, 5362.088444964355, 5391.272178255935, 4758.881027974302, 4847.321375007484, 4853.854384368475, 4856.271559266103, 5067.797288108472, 4956.355673762406, 5025.195968645017, 5031.52200540948, 5038.697678139305, 5081.6696914700615, 4766.8569942901595, 4807.951920480786, 4864.708117512961, 4873.951260487385, 4945.307656928033, 4822.300766388889, 4823.0, 4842.539958703917, 4842.58837998767, 4967.652264341497, 4841.176999909989, 4872.902541949176, 4873.098476781806, 4877.122118018755, 4930.013997200538, 5152.252923326097, 5169.948300516984, 5219.869503262449, 5230.189320655304, 5289.338832645919, 5653.689047102408, 5671.177679236487, 5701.116326969326, 5728.05487094633, 5735.483806457397, 5724.570657200685, 5736.541076713853, 5738.770449182028, 5772.018756811311, 5800.651960882361, 5248.448912864171, 5266.315379000705, 5317.627766056377, 5321.547668448148, 5406.189071639285, 5860.912086318709, 5892.234009578728, 5912.0, 5920.0, 5927.525797936155, 5503.889922201533, 5653.9151912721345, 5698.059820129715, 5698.6580805151825, 5701.800436984769, 5653.462921022497, 5774.191613174159, 5783.103618939072, 5810.0, 5818.7672493100645, 5662.292213473316, 5717.999350113713, 5719.742611582489, 5725.370209276976, 5726.742296596663, 5570.192322113271, 5618.85952851182, 5655.632383895034, 5659.490645841894, 5662.631928924607, 4355.063661312833, 4367.061081867414, 4368.104538569649, 4379.846705365297, 4402.779861007001, 3882.398228274622, 3887.5140607424073, 3903.219356128729, 3905.9609403906165, 3928.5874983126932, 5234.633575649668, 5236.450172731808, 5320.494553017457, 5454.809081682122, 5498.120300751861, 5719.370869204384, 5727.341355744143, 5751.539876809845, 5759.65442073477, 5801.042827933428, 5386.811461598903, 5403.081476149064, 5417.295751552273, 5430.266913966643, 5444.482774136451, 4813.518648135158, 4923.8276660316715, 4941.0, 4942.135126352874, 4992.0, 5912.23140991677, 5939.851503712442, 5956.285245770535, 5959.28488581373, 6009.609375390673, 5755.309362876482, 5771.797987070432, 5772.740226689725, 5777.3933736957015, 5789.102689083199, 5711.171880077282, 5825.70871456434, 5848.005839007294, 5883.0293001654245, 5931.822045338647, 5612.522935550524, 5612.7754889803955, 5615.775368985358, 5616.719164041863, 5618.129189975561, 5679.9148012779015, 5716.485516303553, 5723.112917497794, 5727.513161381329, 5742.397048309867, 5429.782808687608, 5556.527695145958, 5580.525655319343, 5617.606767526234, 5664.150377443417, 5623.8594035149445, 5637.43625637433, 5641.323041235078, 5643.1535269709875, 5652.293463317085, 5417.6478528895495, 5519.061759500814, 5556.527695145958, 5568.860778480571, 5572.777088916398, 5514.0, 5567.164925261243, 5567.721613919207, 5638.5489160867855, 5640.746166422603, 5457.426970168234, 5471.644343117685, 5472.124460086367, 5473.233747275305, 5478.890422191614], "value": 5276.198782610544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.0774173577445, 638.2213699286868, 641.6791604197902, 649.8797722421352, 663.847315117523, 43743.562564374384, 45341.09317813642, 45344.999999999956, 48726.51273487264, 48888.0, 47357.0, 47897.0, 47970.28044579325, 47974.52025479744, 48002.27996580045, 8984.595693193789, 9113.68102116426, 9114.77213069672, 9116.8632470513, 9120.908790912106, 8955.686550970717, 9058.864117038249, 9066.365354425192, 9073.682421115262, 9079.092090790935, 9121.863172052424, 9172.587233574472, 9179.127982841619, 9182.0, 9183.0, 8992.415492992934, 9023.368364214508, 9070.727878163665, 9079.727608171732, 9082.863757043584, 8843.292536597057, 8903.599338029804, 8905.243054340388, 8911.331650126202, 8929.508877011762, 43786.34320485195, 44162.337564936555, 44271.557284427065, 44284.335734964, 44286.0, 3687.668109870098, 3777.5089238399105, 3799.563050249229, 4103.117829666636, 4313.8490152844815, 32943.0, 33322.666773332196, 33341.666583334096, 33571.0, 33648.32703345944, 4280.721753086071, 4285.528591854893, 4301.2902871026245, 4342.091510424707, 4392.209402307583, 355941.0, 357524.42475575174, 358264.0, 358460.0, 358686.9999999974, 50398.49601503938, 56835.0, 57476.0, 57575.424245757844, 57587.0, 51169.744151279, 54770.452295476534, 54783.726081369336, 62849.0, 63602.68198658977, 16332.428365007168, 16402.671946561, 16464.341426343053, 16482.83517164837, 16489.6702065958, 12130.150889437655, 12172.878271217174, 12186.146969712212, 12194.207376520499, 12207.328596927255, 15545.30046147926, 17339.56651083733, 17356.826431735775, 17560.91219543894, 17567.12164391775, 5903.586748927534, 5957.942761512886, 6036.8188954331445, 6046.427928738472, 6087.573869829158, 977.672479719302, 1003.3678782367208, 1107.4352080439035, 1154.1286328821686, 1246.6945598328468, 31754.523682144787, 32785.50821737676, 32863.295359822136, 33003.0, 33394.66605333964, 1147.9598214062469, 1180.9055275577932, 1181.4151994762647, 1195.862475815275, 1229.4590380232669, 17393.826061739474, 17512.38706645261, 17674.469765907044, 17680.204390802446, 17753.822461775475, 519317.0, 522069.0, 522335.0, 523197.0, 525711.0, 57325.0, 57678.711606442535, 57735.71132144312, 57818.13272800911, 58045.0, 1296.6174978381212, 1395.0792476965357, 1397.1547213935423, 1416.0158689710759, 1432.298173894805, 30360.84819575888, 34219.65780342164, 34373.70328708911, 34536.0, 34966.30067398689, 49142.75428622834, 59659.70170149121, 60595.39404605897, 60955.39044609497, 61002.084968724615, 320689.0, 322976.0, 323978.0, 408438.0, 410457.0, 39179.0, 39816.0, 39865.80067099646, 45274.77362613166, 46627.53372466232, 45923.31115033344, 47931.76034119807, 50752.23871641854, 51540.71148221324, 52053.479465204866, 42215.0, 43066.0, 43980.78009609931, 44152.0, 44998.10003799971, 42950.0, 43446.56553434425, 43562.0, 43714.34428483512, 43919.34120988124, 41746.791266043474, 43966.780166098964, 44997.0, 45128.774356129325, 45267.77366113148, 37316.440253396766, 39167.804160979016, 39633.0, 40717.59282407256, 40764.59235407608, 29720.20456011057, 29739.51302434913, 29813.25466863259, 29862.0, 30317.0], "value": 20699.619504156082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.67372375447735, 384.81336551772404, 387.1173723909487, 398.2532751091703, 407.71256264333647, 17524.123793810322, 19000.714989275173, 20011.299604513846, 20023.899880500594, 20047.298344557945, 18286.17712202951, 18494.16776245069, 18761.343352982614, 18939.43181704551, 19043.333483328086, 5445.264889239941, 5584.050711379055, 5664.0937450008005, 5694.2312787773535, 5710.0, 5507.0, 5596.608237423382, 5612.466815652527, 5620.690862002588, 5665.603407761459, 5373.113436283009, 5602.1596760486045, 5608.6073974821775, 5610.186522954169, 5645.830625081234, 5667.4615911488345, 5667.716614169296, 5684.204211410406, 5686.2039314496005, 5710.628809127415, 5325.440828712968, 5529.585281103933, 5585.664860108406, 5597.524210442118, 5597.972010139923, 12132.150749447454, 12235.204711693801, 12238.265704057785, 12262.0, 12489.687757806038, 2269.716285464317, 2380.1669415704364, 2458.0045081741923, 2609.699884513267, 2847.288177955511, 9007.1893529582, 9525.19035881951, 9605.90394096057, 9665.0, 9895.307328487008, 1924.2976313645559, 1942.7377304064053, 1978.357033963953, 2005.8595898287126, 2011.386527109231, 69470.65264673695, 80523.0, 84137.15862841354, 84733.57633211794, 85987.57006214991, 10877.83683244752, 10964.28732132409, 10979.188433908315, 10986.670399888017, 11244.55021799119, 14112.294385280695, 14653.926730366493, 14693.55919322422, 14806.777898331318, 14807.259637018105, 7845.725399610987, 7936.0, 7981.241782030698, 8064.112947575762, 8084.919150808534, 7545.207753185946, 7599.164091949881, 7613.733519326908, 7654.540727556365, 7671.808204794925, 4188.308929026676, 4280.101178752497, 4300.526942036374, 4342.261815491374, 4409.316555933835, 1773.1488885335111, 1812.338496448813, 1854.4622059602564, 1866.7106598477258, 1897.3359324236683, 404.668172098882, 406.37621251378994, 409.709106534358, 415.96880233982574, 1029.8815636201782, 10664.733381665521, 10727.302725322985, 10758.139348852073, 10939.83590246147, 11111.83332250017, 422.4571425717938, 427.75617897798577, 429.6584215548646, 434.07325360355867, 445.9687821852504, 5744.310682718101, 5818.883622327615, 5819.418058194146, 5849.64902105875, 5945.40545945402, 494390.0, 500260.0, 509970.0, 510508.0, 513565.0, 70323.29676703167, 82443.0, 86351.0, 96186.51906740421, 98794.0, 393.7539038101187, 400.6254152367546, 405.7707395321693, 406.6645017860277, 408.2691981353344, 10212.438315892698, 10569.63006294776, 10747.785044299226, 10751.408672522773, 10793.67618971432, 37115.44326835153, 39126.6087339123, 39812.0, 40024.0, 40327.99999999883, 55997.16004259858, 56907.0, 56977.430225697215, 57095.0, 57184.0, 7091.326323999212, 8039.0, 8078.838423231385, 8208.671653134046, 8209.0, 10608.363498189825, 13668.111572748137, 13728.382222799799, 13737.450501980209, 13751.174929504261, 11260.887391125983, 11468.369239691898, 11789.351585662871, 11974.461149248478, 12113.757724845278, 11036.227464077438, 11224.045956093823, 11758.235714678518, 11840.407979600814, 11864.40677966081, 6699.933000670126, 10311.432871192157, 11358.0, 11397.202195846212, 12450.25298482094, 7247.528910620793, 7305.1599066105955, 7386.039814824038, 7446.70213191488, 7520.473566850268, 11067.446627668745, 11354.489047992694, 11489.942550287195, 11565.537378504765, 11607.76784464289], "value": 7909.115194662109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.9585712428618, 1504.5411149599372, 1542.3856563125503, 1672.7490876368543, 1804.9458516244517, 8508.702195423153, 8808.119188081197, 8813.647454101836, 9101.544922753868, 9110.316726245524, 8867.68963086292, 9065.501397423139, 9069.0, 9079.81840363194, 9080.091990800916, 1873.8688291819578, 2109.5464475137883, 2144.5174835662006, 2162.805347518723, 2224.3882932193615, 2194.9231776887814, 2196.4508872781803, 2203.724534433196, 2203.966940495894, 2205.547862688153, 2064.576761763835, 2110.7361579802523, 2112.598606264805, 2113.968290475644, 2115.153938424627, 1903.8857668539931, 2100.674395468697, 2138.893055347242, 2145.3778404262744, 2148.967765483519, 2049.8975051247526, 2054.794520547933, 2055.2292890166186, 2056.969145462819, 2073.170731707314, 8664.176903194186, 8789.384743067987, 8789.604467798901, 8798.0, 8798.164174403422, 5128.692278463304, 5247.212918062283, 5253.238280449314, 5258.526732594047, 5260.736963151827, 3254.576905002358, 3329.70032697056, 3344.866205351783, 3347.7656564040526, 3402.387570237356, 1064.7178497698117, 1071.7588542577935, 1074.6722249713835, 1081.3565928272665, 1151.2657438583365, 13016.674583135402, 13031.934840325832, 13042.543510977164, 13058.2817945013, 13068.738625227537, 4480.193565158238, 4512.616427603625, 4552.317152427162, 4587.931181032287, 4609.608183304456, 10874.075703565128, 10874.67375978722, 10899.29154604948, 10913.508892099875, 10918.12654987615, 4711.976440117777, 5224.555912747383, 5229.843104706865, 5252.9737351313, 5270.209468579744, 4389.056352884145, 4452.777361131995, 4675.602573781199, 4766.928496072562, 4803.95196048042, 3921.9803900980314, 3973.2252210818615, 4046.393041043867, 4064.9796751016056, 4094.836206551764, 1180.144395313408, 1194.8864857838491, 1196.5333519927235, 1215.0583297943988, 1223.902087832989, 923.6259314977444, 1021.7190272675074, 1039.4023436524028, 1055.9577616895392, 1064.3932958213743, 6288.339724328971, 6393.872122557523, 6475.190601174853, 6501.772437964649, 6538.673066346663, 405.126951419691, 409.38387726472064, 411.30900087852694, 412.67811107336325, 415.1261594343923, 4328.523862375137, 4442.244818380883, 4498.59512643857, 4545.522720114341, 4551.52209018055, 10922.508487118099, 11326.773464530663, 11349.489272982735, 11363.829542556869, 11376.715582110348, 10764.0, 11186.0, 11203.383813890152, 11483.25358851672, 11496.827547586792, 8381.203785640355, 8443.95778021106, 8609.397342185986, 8663.0, 8663.350248731243, 6240.53196010292, 6258.812235632939, 6382.393672601095, 6390.105385246162, 6460.45086167681, 10184.847227291448, 10674.57301707923, 10741.227697429837, 10766.676999690022, 10797.62208322705, 10475.266731328733, 10766.515506802056, 10775.622853200413, 10821.51303191374, 10829.783404332027, 7059.717611295696, 7782.299593036654, 8013.278804907586, 8052.5571093590415, 8190.590470476333, 8777.473351598925, 8808.163224493663, 8837.072107428885, 8884.422512536665, 8893.688720894737, 7659.119201291923, 8001.0, 8179.591020449073, 8189.262966333059, 8383.53890536002, 7992.240737129963, 8207.097219305751, 8281.627326770189, 8304.418690691593, 8315.501069935823, 6858.0, 7083.610401427971, 7096.858062838817, 7177.641117943977, 7250.528715633467, 5178.689278643294, 5468.152436372368, 5477.917831232455, 5537.224788529689, 5555.666660000413, 5660.066089095253, 5674.517665998436, 5679.574031947703, 5726.370099289158, 5726.685032323262], "value": 4581.917756749131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.40323973112027, 309.34419031652897, 311.93449375631116, 315.1082436704128, 316.1732070635288, 5222.138347172717, 5278.815241466549, 5287.312649355588, 5302.549283310923, 5355.410904800468, 5247.186686063656, 5256.369235691713, 5263.236830659552, 5280.204730391666, 5337.733113344337, 3946.506686664167, 3967.444557761916, 4083.4691490106243, 4086.795660216992, 4114.8971275718195, 4044.5550989391145, 4068.6338229559333, 4076.449679293302, 4086.2440448516973, 4105.035316700573, 3953.8138558432497, 4024.879253622396, 4034.677225821942, 4039.131586708857, 4062.3906414037833, 3969.126792105732, 4028.7582745035247, 4054.506478515721, 4058.8782336529953, 4083.4283200351974, 3580.087077795172, 3589.8025608591515, 3596.5684117906017, 3599.3521166190076, 3620.637936206358, 5061.190209566452, 5080.542751152377, 5089.898202035975, 5104.617153713486, 5111.693298402108, 4552.884543286883, 4658.021815418766, 4668.533146685339, 4671.836485723017, 4693.976530117362, 5460.918086228709, 5485.945140548583, 5558.0, 5566.165075238706, 5581.832545023656, 3982.123932734794, 3995.640392364672, 4000.5399379071487, 4010.2581022510635, 4013.3779264214095, 5590.651926190969, 5648.096304591246, 5660.716964151776, 5689.544836413118, 5698.951061182289, 4006.899827504336, 4011.5988401159652, 4036.990752311922, 4037.313656678372, 4040.898977525527, 4089.6523795477124, 4121.175764847043, 4123.8969025774595, 4151.667866570667, 4151.73013754105, 4578.0157266187925, 4579.22153233951, 4612.238980568236, 4649.511801260819, 4752.334673145762, 5444.393903798389, 5453.0, 5474.7262636868, 5525.4474552544425, 5576.135698966586, 1404.7401230772339, 1426.165693069566, 1433.6129245103764, 1434.823444775295, 1443.8449240607472, 901.985266575103, 915.2266334946959, 949.9097585729345, 950.2398081534883, 952.8570714392896, 5207.270982062514, 5238.60710446718, 5239.842804715865, 5272.657277276965, 5284.445133260952, 5574.526165275997, 5583.832485025456, 5596.608237423341, 5620.831375058755, 5622.915656265078, 5008.974955125201, 5229.686218826882, 5261.0, 5289.576833853283, 5317.500774635915, 2971.7919745618033, 2974.3456439583256, 2977.791554591201, 3002.288695443576, 3017.230606195406, 5710.914336284959, 5726.024521540062, 5733.598648094593, 5762.193292938992, 5767.336756272998, 5483.396826349099, 5757.88484230313, 5783.033768518724, 5794.768209271582, 5875.324337701134, 5850.444207800252, 5873.882522349529, 5879.147523609053, 5898.3216930053595, 5923.7926672566255, 5579.69311687861, 5697.914531282117, 5703.543716502752, 5746.569007324384, 5750.367459579359, 5607.775688972395, 5646.745896434588, 5653.208550802973, 5662.490375866192, 5664.320281566238, 5884.7940322090235, 5889.587728858939, 5889.732453005709, 5909.6158749681135, 5920.579061025237, 3732.197577520846, 3931.8034098294397, 3955.6044395560216, 3958.584348643351, 3961.1681546874324, 5539.972300138474, 5581.944180558143, 5639.943600563942, 5648.322201335702, 5674.57440691958, 5323.441038691037, 5367.382750983531, 5552.555795536428, 5555.472230138131, 5560.082586373203, 5528.695921724344, 5533.253010843646, 5533.438893911593, 5536.833894983157, 5567.9977604031665, 5225.973870130625, 5409.918851217313, 5420.9186862197885, 5457.754401051883, 5463.562914966873, 5557.749901254372, 5587.74855131512, 5605.243292155506, 5612.484629150025, 5613.438656134354, 5382.811601593926, 5445.591580631548, 5485.149801780731, 5491.615586909038, 5501.0], "value": 4194.303337215115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.140307367457, 740.389178927385, 747.0251322024759, 760.3157158557299, 784.9097353804312, 14346.497872574462, 15991.520254392371, 16438.589035274123, 16484.258208380623, 17069.40257091002, 14826.0, 15082.245887705625, 15263.694726105472, 15366.462173823918, 15399.615009624737, 689.5655736885755, 799.4683535448919, 835.7158566087529, 843.3421930893912, 843.8818565400849, 838.6100463284572, 844.3540691371076, 844.586152785137, 844.5945945945949, 849.0660273698912, 868.6872725818732, 879.6437442835662, 883.5670521444478, 883.9911600883974, 884.0099089020306, 728.6283995162479, 854.679495189304, 874.5190145420057, 875.7591662292889, 876.8027193881389, 621.6425555305672, 622.017212803769, 622.4553515673786, 622.5362105231632, 623.9251289845203, 14801.851981480155, 14830.555083347517, 14832.332545035499, 14861.554153375417, 14861.851381486264, 13246.66883327915, 13538.864611353958, 13644.454221831114, 13660.931695341558, 13884.4446222151, 12008.939955300255, 12270.877291227063, 12280.078994075391, 12369.381530923507, 12395.318257495834, 4503.301988191803, 4546.0, 4597.126545956257, 4684.718916864999, 4717.622590192776, 59000.11499827506, 59396.70301648507, 59515.0, 59671.70164149195, 60219.0, 10883.85538351884, 10929.508172132273, 10943.507542160622, 10963.50664220112, 11186.608468703556, 18001.7299740504, 18024.36914708005, 18037.27850885976, 18047.458576242734, 18071.909640451977, 8586.699465518677, 8752.824943501222, 8834.249088827393, 8937.240334571505, 9017.819643607223, 4852.223644216909, 4875.390576177978, 4975.278584605212, 5078.898422031539, 5138.58891288696, 3509.2279698466295, 3612.0, 3632.600413954463, 3634.454831775202, 3638.326909521747, 689.9448044156455, 724.5435375713372, 726.4333819620705, 744.244591739385, 747.1818358896999, 763.9312461878458, 781.8279978404742, 782.6908371193347, 784.7645706288091, 817.8977627796526, 9207.447553146832, 9437.528123593793, 9738.659146929824, 9764.609415623438, 9943.502824858728, 737.6459299536252, 741.2735519191223, 765.016953215127, 804.9839003219903, 815.6085079162035, 4458.420405347284, 4487.573680500347, 4635.837745678885, 4718.504557021532, 4778.450478194983, 71801.6409917947, 76998.0, 77044.3643593886, 77912.0, 78086.6095669518, 63667.36332636707, 64837.67581162064, 65468.34531654623, 67167.0, 67410.32589674139, 56876.43123568794, 59142.0, 59348.7032564843, 60081.699591502635, 60175.699121504986, 9380.249580033444, 9398.34211605181, 9408.576614052246, 9470.621175152917, 9523.857142143012, 38996.415053774785, 40368.0, 40570.18859622732, 40607.3908891361, 41349.79325103355, 50721.492785073155, 54750.726246370104, 54927.45072549383, 55276.44723552713, 56021.71989140028, 11665.183437159318, 11841.46713397882, 12349.567765128177, 12761.553345632858, 12774.68063298425, 14162.78755818643, 14201.289935502977, 14235.64410889736, 14248.786268206193, 15042.0, 13742.0, 13750.587482375544, 13862.098963567336, 14065.648358791112, 14839.0, 12286.87713122893, 13162.60512184636, 13171.60485185446, 13446.394912229169, 13788.172709637454, 13101.863416096241, 13315.933420332836, 13686.110402823784, 14102.153870767786, 14207.715845683235, 10956.835647465454, 11297.0, 11308.321500709984, 11471.541138354372, 12048.698782530508, 11254.606088786853, 11412.828807567726, 11417.657470275904, 11559.248648837798, 11606.187566870238], "value": 7233.803642147428, "unit": "score"}], "name": "dromaeo_css", "value": 7024.064197971236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 109.0, 109.0, 110.0, 110.0, 111.0, 109.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 153.0, 207.0, 122.0, 152.0, 154.0, 124.0, 179.0, 125.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 150.0, 77.0, 75.0, 76.0, 75.0, 132.0, 76.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 157.0, 92.0, 92.0, 92.0, 136.0, 91.0, 91.0, 116.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 55.0, 54.0, 55.0, 106.0, 52.0, 54.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 83.0, 82.0, 78.0, 79.0, 86.0, 81.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 121.0, 126.0, 133.0, 123.0, 116.0, 117.0, 199.0, 122.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 162.0, 158.0, 157.0, 157.0, 157.0, 164.0, 161.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 65.0, 64.0, 62.0, 63.0, 61.0, 64.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1520.6, "alertThreshold": 2.0}]} 23:29:10 INFO - Return code: 0 23:29:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:29:10 ERROR - # TBPL SUCCESS # 23:29:10 INFO - Running post-action listener: _resource_record_post_action 23:29:10 INFO - ##### 23:29:10 INFO - ##### Finished run-tests step (success) 23:29:10 INFO - ##### 23:29:10 INFO - Running post-run listener: _resource_record_post_run 23:29:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 536231936; Read time: 0; Write time: 457856 23:29:10 INFO - TinderboxPrint: CPU usage
13.0% 23:29:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:29:10 INFO - TinderboxPrint: I/O write bytes / time
536,231,936 / 457,856 23:29:10 INFO - TinderboxPrint: CPU idle
8,285.9 (86.9%) 23:29:10 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 23:29:10 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246521856; Read time: 0; Write time: 231692 23:29:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289710080; Read time: 0; Write time: 226164 23:29:11 INFO - Running post-run listener: _upload_blobber_files 23:29:11 INFO - Blob upload gear active. 23:29:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:11 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 23:29:11 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'] 23:29:11 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 23:29:11 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:12 INFO - (blobuploader) - INFO - Done attempting. 23:29:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:29:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:29:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:13 INFO - (blobuploader) - INFO - Done attempting. 23:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:17 INFO - (blobuploader) - INFO - Done attempting. 23:29:17 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:17 INFO - Return code: 0 23:29:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d1a214834669f6ca18a3a3d8bd2f8f62721217ee00cbf5be896587d27c5108e09fc3369e8d5362a6ea11116fe1269d5c1381866c87d63739a1a0d7f579b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82941e0290336c0fae123ed034b955e361b2199bf3aaa9235c51eef8a835e0444122733f748faa5d58ee9ea56ba82b6e673a70bdae7e53688f1eadb888193ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57b2ea940f69f0096c89d5664cafba95b208ec5de58ef5448ce318ac732812e939b96243e8ea7fbdabe5716ce0bdf3bc5fcb6741d8e1845e9a1901e986e81330"} 23:29:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:17 INFO - Contents: 23:29:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b83d1a214834669f6ca18a3a3d8bd2f8f62721217ee00cbf5be896587d27c5108e09fc3369e8d5362a6ea11116fe1269d5c1381866c87d63739a1a0d7f579b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82941e0290336c0fae123ed034b955e361b2199bf3aaa9235c51eef8a835e0444122733f748faa5d58ee9ea56ba82b6e673a70bdae7e53688f1eadb888193ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57b2ea940f69f0096c89d5664cafba95b208ec5de58ef5448ce318ac732812e939b96243e8ea7fbdabe5716ce0bdf3bc5fcb6741d8e1845e9a1901e986e81330"} 23:29:17 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:17 INFO - Copying logs to upload dir... 23:29:17 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.131421 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-15 23:29:15.991503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 23:29:15.994993) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 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/b83d1a214834669f6ca18a3a3d8bd2f8f62721217ee00cbf5be896587d27c5108e09fc3369e8d5362a6ea11116fe1269d5c1381866c87d63739a1a0d7f579b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82941e0290336c0fae123ed034b955e361b2199bf3aaa9235c51eef8a835e0444122733f748faa5d58ee9ea56ba82b6e673a70bdae7e53688f1eadb888193ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57b2ea940f69f0096c89d5664cafba95b208ec5de58ef5448ce318ac732812e939b96243e8ea7fbdabe5716ce0bdf3bc5fcb6741d8e1845e9a1901e986e81330"} build_url:https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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/b83d1a214834669f6ca18a3a3d8bd2f8f62721217ee00cbf5be896587d27c5108e09fc3369e8d5362a6ea11116fe1269d5c1381866c87d63739a1a0d7f579b4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82941e0290336c0fae123ed034b955e361b2199bf3aaa9235c51eef8a835e0444122733f748faa5d58ee9ea56ba82b6e673a70bdae7e53688f1eadb888193ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57b2ea940f69f0096c89d5664cafba95b208ec5de58ef5448ce318ac732812e939b96243e8ea7fbdabe5716ce0bdf3bc5fcb6741d8e1845e9a1901e986e81330"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 23:29:16.019745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:29:16.020108) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463377283.156199-482655392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:29:16.105414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 23:29:16.105734) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 23:29:16.106065) ========= ========= Total master_lag: 0.16 =========