builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1464795256.68 results: success (0) buildid: 20160601075442 builduid: 6ec167071a674293aaa469b2f4523092 revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.684040) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.684484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.684761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.699999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.700314) ========= 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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 08:34:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-01 08:34:16 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.835885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.836195) ========= 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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.885233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:16.885591) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 --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 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 --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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 08:34:17,056 truncating revision to first 12 chars 2016-06-01 08:34:17,056 Setting DEBUG logging. 2016-06-01 08:34:17,056 attempt 1/10 2016-06-01 08:34:17,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5d2cb7fff024?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 08:34:17,426 unpacking tar archive at: fx-team-5d2cb7fff024/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:17.626058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:17.626381) ========= script_repo_revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:17.626776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:17.627042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 08:34:17.634434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-01 08:34:17.634727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:34:17 INFO - MultiFileLogger online at 20160601 08:34:17 in /builds/slave/test 08:34:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:34:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:17 INFO - {'append_to_log': False, 08:34:17 INFO - 'base_work_dir': '/builds/slave/test', 08:34:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:34:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:17 INFO - 'branch': 'Fx-Team-Non-PGO', 08:34:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:17 INFO - 'config_files': ('talos/linux_config.py',), 08:34:17 INFO - 'default_actions': ('clobber', 08:34:17 INFO - 'read-buildbot-config', 08:34:17 INFO - 'download-and-extract', 08:34:17 INFO - 'populate-webroot', 08:34:17 INFO - 'create-virtualenv', 08:34:17 INFO - 'install', 08:34:17 INFO - 'run-tests'), 08:34:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:17 INFO - 'download_minidump_stackwalk': True, 08:34:17 INFO - 'download_symbols': 'ondemand', 08:34:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:17 INFO - 'installer_path': 'installer.exe', 08:34:17 INFO - 'log_level': 'info', 08:34:17 INFO - 'log_name': 'talos', 08:34:17 INFO - 'log_to_console': True, 08:34:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:34:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:34:17 INFO - 'opt_config_files': (), 08:34:17 INFO - 'pip_index': False, 08:34:17 INFO - 'sps_profile': False, 08:34:17 INFO - 'sps_profile_interval': 0, 08:34:17 INFO - 'suite': 'dromaeojs-e10s', 08:34:17 INFO - 'system_bits': '32', 08:34:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:17 INFO - 'title': 'talos-linux64-ix-016', 08:34:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:17 INFO - 'use_talos_json': True, 08:34:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:17 INFO - 'work_dir': 'build'} 08:34:17 INFO - ##### 08:34:17 INFO - ##### Running clobber step. 08:34:17 INFO - ##### 08:34:17 INFO - Running pre-action listener: _resource_record_pre_action 08:34:17 INFO - Running main action method: clobber 08:34:17 INFO - rmtree: /builds/slave/test/build 08:34:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:18 INFO - Running post-action listener: _resource_record_post_action 08:34:18 INFO - ##### 08:34:18 INFO - ##### Finished clobber step (success) 08:34:18 INFO - ##### 08:34:18 INFO - ##### 08:34:18 INFO - ##### Running read-buildbot-config step. 08:34:18 INFO - ##### 08:34:18 INFO - Running pre-action listener: _resource_record_pre_action 08:34:18 INFO - Running main action method: read_buildbot_config 08:34:18 INFO - Using buildbot properties: 08:34:18 INFO - { 08:34:18 INFO - "project": "", 08:34:18 INFO - "product": "firefox", 08:34:18 INFO - "script_repo_revision": "production", 08:34:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:34:18 INFO - "repository": "", 08:34:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:34:18 INFO - "buildid": "20160601075442", 08:34:18 INFO - "pgo_build": "False", 08:34:18 INFO - "basedir": "/builds/slave/test", 08:34:18 INFO - "buildnumber": 1361, 08:34:18 INFO - "slavename": "talos-linux64-ix-016", 08:34:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:34:18 INFO - "platform": "ubuntu64_hw", 08:34:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:34:18 INFO - "branch": "fx-team", 08:34:18 INFO - "repo_path": "integration/fx-team", 08:34:18 INFO - "revision": "5d2cb7fff024a1d3ed59ad2432882d158ce5ee91", 08:34:18 INFO - "stage_platform": "linux64", 08:34:18 INFO - "builduid": "6ec167071a674293aaa469b2f4523092", 08:34:18 INFO - "slavebuilddir": "test" 08:34:18 INFO - } 08:34:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:34:18 INFO - Running post-action listener: _resource_record_post_action 08:34:18 INFO - ##### 08:34:18 INFO - ##### Finished read-buildbot-config step (success) 08:34:18 INFO - ##### 08:34:18 INFO - ##### 08:34:18 INFO - ##### Running download-and-extract step. 08:34:18 INFO - ##### 08:34:18 INFO - Running pre-action listener: _resource_record_pre_action 08:34:18 INFO - Running main action method: download_and_extract 08:34:18 INFO - mkdir: /builds/slave/test/build/tests 08:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:18 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:34:19 INFO - Downloaded 1361 bytes. 08:34:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:34:19 INFO - Using the following test package requirements: 08:34:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:34:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:34:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'jsshell-linux-x86_64.zip'], 08:34:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:34:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:34:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:34:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:34:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:34:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:19 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:20 INFO - Downloaded 22849784 bytes. 08:34:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:34:21 INFO - Return code: 0 08:34:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:21 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:23 INFO - Downloaded 22849784 bytes. 08:34:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:34:24 INFO - Return code: 0 08:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:24 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:34:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:34:25 INFO - Downloaded 10834055 bytes. 08:34:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:34:25 INFO - Return code: 0 08:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:25 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:34:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:34:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:34:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:34:27 INFO - Downloaded 55062799 bytes. 08:34:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:34:27 INFO - mkdir: /builds/slave/test/properties 08:34:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:27 INFO - Contents: 08:34:27 INFO - build_url:https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:34:27 INFO - Running post-action listener: _resource_record_post_action 08:34:27 INFO - Running post-action listener: set_extra_try_arguments 08:34:27 INFO - ##### 08:34:27 INFO - ##### Finished download-and-extract step (success) 08:34:27 INFO - ##### 08:34:27 INFO - ##### 08:34:27 INFO - ##### Running populate-webroot step. 08:34:27 INFO - ##### 08:34:27 INFO - Running pre-action listener: _resource_record_pre_action 08:34:27 INFO - Running main action method: populate_webroot 08:34:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:28 INFO - '--tppagecycles', 08:34:28 INFO - '7'], 08:34:28 INFO - 'tests': ['tsvgm']}}, 08:34:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['damp', 'tps']}, 08:34:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'tests': ['damp', 'tps']}, 08:34:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['dromaeo_dom']}, 08:34:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['a11yr', 08:34:28 INFO - 'ts_paint', 08:34:28 INFO - 'tpaint', 08:34:28 INFO - 'sessionrestore', 08:34:28 INFO - 'sessionrestore_no_auto_restore', 08:34:28 INFO - 'tabpaint']}, 08:34:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['tsvgx', 08:34:28 INFO - 'tsvgr_opacity', 08:34:28 INFO - 'tart', 08:34:28 INFO - 'tscrollx', 08:34:28 INFO - 'cart']}, 08:34:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:28 INFO - 'tsvgr_opacity', 08:34:28 INFO - 'tart', 08:34:28 INFO - 'tscrollx', 08:34:28 INFO - 'cart']}, 08:34:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'talos_options': ['--disable-e10s'], 08:34:28 INFO - 'tests': ['tp5o']}, 08:34:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'tests': ['tp5o']}, 08:34:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'talos_options': ['--disable-e10s', 08:34:28 INFO - '--xperf_path', 08:34:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:28 INFO - 'tests': ['tp5n']}, 08:34:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:28 INFO - 'talos_options': ['--xperf_path', 08:34:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:28 INFO - 'tests': ['tp5n']}}, 08:34:28 INFO - 'talos.zip': {'path': '', 08:34:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:28 INFO - Running post-action listener: _resource_record_post_action 08:34:28 INFO - ##### 08:34:28 INFO - ##### Finished populate-webroot step (success) 08:34:28 INFO - ##### 08:34:28 INFO - ##### 08:34:28 INFO - ##### Running create-virtualenv step. 08:34:28 INFO - ##### 08:34:28 INFO - Running pre-action listener: _resource_record_pre_action 08:34:28 INFO - Running main action method: create_virtualenv 08:34:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:34:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:28 INFO - Using real prefix '/usr' 08:34:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:30 INFO - Installing pip.................done. 08:34:30 INFO - Return code: 0 08:34:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:30 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:34:30 INFO - Using env: {'DISPLAY': ':0', 08:34:30 INFO - 'HOME': '/home/cltbld', 08:34:30 INFO - 'LANG': 'en_US.UTF-8', 08:34:30 INFO - 'LANGUAGE': 'en_US:en', 08:34:30 INFO - 'LOGNAME': 'cltbld', 08:34:30 INFO - 'MAIL': '/var/mail/cltbld', 08:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:30 INFO - 'MOZ_NO_REMOTE': '1', 08:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:30 INFO - 'NO_EM_RESTART': '1', 08:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:30 INFO - 'PWD': '/builds/slave/test', 08:34:30 INFO - 'SHELL': '/bin/bash', 08:34:30 INFO - 'SHLVL': '1', 08:34:30 INFO - 'TERM': 'linux', 08:34:30 INFO - 'TMOUT': '86400', 08:34:30 INFO - 'USER': 'cltbld', 08:34:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:30 INFO - '_': '/tools/buildbot/bin/python'} 08:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:34:30 INFO - Cleaning up... 08:34:30 INFO - Return code: 0 08:34:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:30 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:34:30 INFO - Using env: {'DISPLAY': ':0', 08:34:30 INFO - 'HOME': '/home/cltbld', 08:34:30 INFO - 'LANG': 'en_US.UTF-8', 08:34:30 INFO - 'LANGUAGE': 'en_US:en', 08:34:30 INFO - 'LOGNAME': 'cltbld', 08:34:30 INFO - 'MAIL': '/var/mail/cltbld', 08:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:30 INFO - 'MOZ_NO_REMOTE': '1', 08:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:30 INFO - 'NO_EM_RESTART': '1', 08:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:30 INFO - 'PWD': '/builds/slave/test', 08:34:30 INFO - 'SHELL': '/bin/bash', 08:34:30 INFO - 'SHLVL': '1', 08:34:30 INFO - 'TERM': 'linux', 08:34:30 INFO - 'TMOUT': '86400', 08:34:30 INFO - 'USER': 'cltbld', 08:34:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:30 INFO - '_': '/tools/buildbot/bin/python'} 08:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:31 INFO - Downloading/unpacking psutil>=3.1.1 08:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:33 INFO - Installing collected packages: psutil 08:34:33 INFO - Running setup.py install for psutil 08:34:33 INFO - building 'psutil._psutil_linux' extension 08:34:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:34:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:34:33 INFO - building 'psutil._psutil_posix' extension 08:34:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:34:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:33 INFO - Successfully installed psutil 08:34:33 INFO - Cleaning up... 08:34:33 INFO - Return code: 0 08:34:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:34:33 INFO - Using env: {'DISPLAY': ':0', 08:34:33 INFO - 'HOME': '/home/cltbld', 08:34:33 INFO - 'LANG': 'en_US.UTF-8', 08:34:33 INFO - 'LANGUAGE': 'en_US:en', 08:34:33 INFO - 'LOGNAME': 'cltbld', 08:34:33 INFO - 'MAIL': '/var/mail/cltbld', 08:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:33 INFO - 'MOZ_NO_REMOTE': '1', 08:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:33 INFO - 'NO_EM_RESTART': '1', 08:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:33 INFO - 'PWD': '/builds/slave/test', 08:34:33 INFO - 'SHELL': '/bin/bash', 08:34:33 INFO - 'SHLVL': '1', 08:34:33 INFO - 'TERM': 'linux', 08:34:33 INFO - 'TMOUT': '86400', 08:34:33 INFO - 'USER': 'cltbld', 08:34:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:33 INFO - '_': '/tools/buildbot/bin/python'} 08:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:34:35 INFO - Installing collected packages: mozsystemmonitor 08:34:35 INFO - Running setup.py install for mozsystemmonitor 08:34:35 INFO - Successfully installed mozsystemmonitor 08:34:35 INFO - Cleaning up... 08:34:35 INFO - Return code: 0 08:34:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:35 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:34:35 INFO - Using env: {'DISPLAY': ':0', 08:34:35 INFO - 'HOME': '/home/cltbld', 08:34:35 INFO - 'LANG': 'en_US.UTF-8', 08:34:35 INFO - 'LANGUAGE': 'en_US:en', 08:34:35 INFO - 'LOGNAME': 'cltbld', 08:34:35 INFO - 'MAIL': '/var/mail/cltbld', 08:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:35 INFO - 'MOZ_NO_REMOTE': '1', 08:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:35 INFO - 'NO_EM_RESTART': '1', 08:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:35 INFO - 'PWD': '/builds/slave/test', 08:34:35 INFO - 'SHELL': '/bin/bash', 08:34:35 INFO - 'SHLVL': '1', 08:34:35 INFO - 'TERM': 'linux', 08:34:35 INFO - 'TMOUT': '86400', 08:34:35 INFO - 'USER': 'cltbld', 08:34:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:35 INFO - '_': '/tools/buildbot/bin/python'} 08:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:38 INFO - Downloading docopt-0.6.1.tar.gz 08:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:38 INFO - Running setup.py install for blobuploader 08:34:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:38 INFO - Running setup.py install for requests 08:34:39 INFO - Running setup.py install for docopt 08:34:39 INFO - Successfully installed blobuploader requests docopt 08:34:39 INFO - Cleaning up... 08:34:39 INFO - Return code: 0 08:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:39 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:34:39 INFO - Using env: {'DISPLAY': ':0', 08:34:39 INFO - 'HOME': '/home/cltbld', 08:34:39 INFO - 'LANG': 'en_US.UTF-8', 08:34:39 INFO - 'LANGUAGE': 'en_US:en', 08:34:39 INFO - 'LOGNAME': 'cltbld', 08:34:39 INFO - 'MAIL': '/var/mail/cltbld', 08:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:39 INFO - 'MOZ_NO_REMOTE': '1', 08:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:39 INFO - 'NO_EM_RESTART': '1', 08:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:39 INFO - 'PWD': '/builds/slave/test', 08:34:39 INFO - 'SHELL': '/bin/bash', 08:34:39 INFO - 'SHLVL': '1', 08:34:39 INFO - 'TERM': 'linux', 08:34:39 INFO - 'TMOUT': '86400', 08:34:39 INFO - 'USER': 'cltbld', 08:34:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:39 INFO - '_': '/tools/buildbot/bin/python'} 08:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:39 INFO - Running setup.py (path:/tmp/pip-ekvJGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:39 INFO - Running setup.py (path:/tmp/pip-x4tm0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:39 INFO - Running setup.py (path:/tmp/pip-_gVKge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:39 INFO - Running setup.py (path:/tmp/pip-w0IRH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:39 INFO - Running setup.py (path:/tmp/pip-Pzgeyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:39 INFO - Running setup.py (path:/tmp/pip-zenIbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:39 INFO - Running setup.py (path:/tmp/pip-VBFuhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:40 INFO - Running setup.py (path:/tmp/pip-KeS5ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:40 INFO - Running setup.py (path:/tmp/pip-xn_uKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:40 INFO - Running setup.py (path:/tmp/pip-kAiJCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:40 INFO - Running setup.py (path:/tmp/pip-yadHuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:40 INFO - Running setup.py (path:/tmp/pip-GhVApm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:40 INFO - Running setup.py (path:/tmp/pip-LnqS1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:40 INFO - Running setup.py (path:/tmp/pip-2wUkCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:40 INFO - Running setup.py (path:/tmp/pip-snB_QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:40 INFO - Running setup.py (path:/tmp/pip-qm7N02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:40 INFO - Running setup.py (path:/tmp/pip-F3oFak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:40 INFO - Running setup.py install for manifestparser 08:34:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:40 INFO - Running setup.py install for mozcrash 08:34:40 INFO - Running setup.py install for mozdebug 08:34:41 INFO - Running setup.py install for mozdevice 08:34:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozfile 08:34:41 INFO - Running setup.py install for mozhttpd 08:34:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozinfo 08:34:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozInstall 08:34:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozleak 08:34:41 INFO - Running setup.py install for mozlog 08:34:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for moznetwork 08:34:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozprocess 08:34:41 INFO - Running setup.py install for mozprofile 08:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Running setup.py install for mozrunner 08:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Running setup.py install for mozscreenshot 08:34:42 INFO - Running setup.py install for moztest 08:34:42 INFO - Running setup.py install for mozversion 08:34:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:42 INFO - Cleaning up... 08:34:42 INFO - Return code: 0 08:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:42 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:34:42 INFO - Using env: {'DISPLAY': ':0', 08:34:42 INFO - 'HOME': '/home/cltbld', 08:34:42 INFO - 'LANG': 'en_US.UTF-8', 08:34:42 INFO - 'LANGUAGE': 'en_US:en', 08:34:42 INFO - 'LOGNAME': 'cltbld', 08:34:42 INFO - 'MAIL': '/var/mail/cltbld', 08:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:42 INFO - 'MOZ_NO_REMOTE': '1', 08:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:42 INFO - 'NO_EM_RESTART': '1', 08:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:42 INFO - 'PWD': '/builds/slave/test', 08:34:42 INFO - 'SHELL': '/bin/bash', 08:34:42 INFO - 'SHLVL': '1', 08:34:42 INFO - 'TERM': 'linux', 08:34:42 INFO - 'TMOUT': '86400', 08:34:42 INFO - 'USER': 'cltbld', 08:34:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:42 INFO - '_': '/tools/buildbot/bin/python'} 08:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:42 INFO - Running setup.py (path:/tmp/pip-r7FBdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:42 INFO - Running setup.py (path:/tmp/pip-ouPtY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:42 INFO - Running setup.py (path:/tmp/pip-5vlkks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:43 INFO - Running setup.py (path:/tmp/pip-_llOhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:43 INFO - Running setup.py (path:/tmp/pip-pvJx4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:43 INFO - Running setup.py (path:/tmp/pip-RUP7_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:43 INFO - Running setup.py (path:/tmp/pip-zX35Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:43 INFO - Running setup.py (path:/tmp/pip-PdM149-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:43 INFO - Running setup.py (path:/tmp/pip-B_yh6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:43 INFO - Running setup.py (path:/tmp/pip-1u7eIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:43 INFO - Running setup.py (path:/tmp/pip-4nCSgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:43 INFO - Running setup.py (path:/tmp/pip-k3tSyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:43 INFO - Running setup.py (path:/tmp/pip-hj2dTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:43 INFO - Running setup.py (path:/tmp/pip-_VmAyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:43 INFO - Running setup.py (path:/tmp/pip-LkbpbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:43 INFO - Running setup.py (path:/tmp/pip-VGlL3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:43 INFO - Running setup.py (path:/tmp/pip-vanCGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:45 INFO - Downloading blessings-1.6.tar.gz 08:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:34:45 INFO - Installing collected packages: blessings 08:34:45 INFO - Running setup.py install for blessings 08:34:46 INFO - Successfully installed blessings 08:34:46 INFO - Cleaning up... 08:34:46 INFO - Return code: 0 08:34:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:46 INFO - Reading from file tmpfile_stdout 08:34:46 INFO - Current package versions: 08:34:46 INFO - argparse == 1.2.1 08:34:46 INFO - blessings == 1.6 08:34:46 INFO - blobuploader == 1.2.4 08:34:46 INFO - docopt == 0.6.1 08:34:46 INFO - manifestparser == 1.1 08:34:46 INFO - mozInstall == 1.12 08:34:46 INFO - mozcrash == 0.17 08:34:46 INFO - mozdebug == 0.1 08:34:46 INFO - mozdevice == 0.48 08:34:46 INFO - mozfile == 1.2 08:34:46 INFO - mozhttpd == 0.7 08:34:46 INFO - mozinfo == 0.9 08:34:46 INFO - mozleak == 0.1 08:34:46 INFO - mozlog == 3.2 08:34:46 INFO - moznetwork == 0.27 08:34:46 INFO - mozprocess == 0.22 08:34:46 INFO - mozprofile == 0.28 08:34:46 INFO - mozrunner == 6.11 08:34:46 INFO - mozscreenshot == 0.1 08:34:46 INFO - mozsystemmonitor == 0.3 08:34:46 INFO - moztest == 0.7 08:34:46 INFO - mozversion == 1.4 08:34:46 INFO - psutil == 3.1.1 08:34:46 INFO - requests == 1.2.3 08:34:46 INFO - wsgiref == 0.1.2 08:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:34:46 INFO - Using env: {'DISPLAY': ':0', 08:34:46 INFO - 'HOME': '/home/cltbld', 08:34:46 INFO - 'LANG': 'en_US.UTF-8', 08:34:46 INFO - 'LANGUAGE': 'en_US:en', 08:34:46 INFO - 'LOGNAME': 'cltbld', 08:34:46 INFO - 'MAIL': '/var/mail/cltbld', 08:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:46 INFO - 'MOZ_NO_REMOTE': '1', 08:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:46 INFO - 'NO_EM_RESTART': '1', 08:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:46 INFO - 'PWD': '/builds/slave/test', 08:34:46 INFO - 'SHELL': '/bin/bash', 08:34:46 INFO - 'SHLVL': '1', 08:34:46 INFO - 'TERM': 'linux', 08:34:46 INFO - 'TMOUT': '86400', 08:34:46 INFO - 'USER': 'cltbld', 08:34:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:46 INFO - '_': '/tools/buildbot/bin/python'} 08:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:34:46 INFO - Cleaning up... 08:34:46 INFO - Return code: 0 08:34:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:34:46 INFO - Using env: {'DISPLAY': ':0', 08:34:46 INFO - 'HOME': '/home/cltbld', 08:34:46 INFO - 'LANG': 'en_US.UTF-8', 08:34:46 INFO - 'LANGUAGE': 'en_US:en', 08:34:46 INFO - 'LOGNAME': 'cltbld', 08:34:46 INFO - 'MAIL': '/var/mail/cltbld', 08:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:46 INFO - 'MOZ_NO_REMOTE': '1', 08:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:46 INFO - 'NO_EM_RESTART': '1', 08:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:46 INFO - 'PWD': '/builds/slave/test', 08:34:46 INFO - 'SHELL': '/bin/bash', 08:34:46 INFO - 'SHLVL': '1', 08:34:46 INFO - 'TERM': 'linux', 08:34:46 INFO - 'TMOUT': '86400', 08:34:46 INFO - 'USER': 'cltbld', 08:34:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:46 INFO - '_': '/tools/buildbot/bin/python'} 08:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:46 INFO - Downloading/unpacking jsonschema 08:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:48 INFO - Downloading/unpacking functools32 (from jsonschema) 08:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:48 INFO - warning: no files found matching '*.txt' 08:34:48 INFO - no previously-included directories found matching 'build' 08:34:48 INFO - no previously-included directories found matching 'dist' 08:34:48 INFO - no previously-included directories found matching '.git*' 08:34:48 INFO - Installing collected packages: jsonschema, functools32 08:34:49 INFO - Running setup.py install for functools32 08:34:49 INFO - warning: no files found matching '*.txt' 08:34:49 INFO - no previously-included directories found matching 'build' 08:34:49 INFO - no previously-included directories found matching 'dist' 08:34:49 INFO - no previously-included directories found matching '.git*' 08:34:49 INFO - Successfully installed jsonschema functools32 08:34:49 INFO - Cleaning up... 08:34:49 INFO - Return code: 0 08:34:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:49 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 0x7fcafe3bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, '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': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:34:49 INFO - Using env: {'DISPLAY': ':0', 08:34:49 INFO - 'HOME': '/home/cltbld', 08:34:49 INFO - 'LANG': 'en_US.UTF-8', 08:34:49 INFO - 'LANGUAGE': 'en_US:en', 08:34:49 INFO - 'LOGNAME': 'cltbld', 08:34:49 INFO - 'MAIL': '/var/mail/cltbld', 08:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:49 INFO - 'MOZ_NO_REMOTE': '1', 08:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:49 INFO - 'NO_EM_RESTART': '1', 08:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:49 INFO - 'PWD': '/builds/slave/test', 08:34:49 INFO - 'SHELL': '/bin/bash', 08:34:49 INFO - 'SHLVL': '1', 08:34:49 INFO - 'TERM': 'linux', 08:34:49 INFO - 'TMOUT': '86400', 08:34:49 INFO - 'USER': 'cltbld', 08:34:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:49 INFO - '_': '/tools/buildbot/bin/python'} 08:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:49 INFO - Downloading/unpacking flake8 08:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:34:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:34:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:34:52 INFO - no previously-included directories found matching 'docs/_build' 08:34:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:34:52 INFO - Running setup.py install for pep8 08:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:34:52 INFO - no previously-included directories found matching 'docs/_build' 08:34:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:34:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:34:52 INFO - Cleaning up... 08:34:52 INFO - Return code: 0 08:34:52 INFO - Running post-action listener: _resource_record_post_action 08:34:52 INFO - Running post-action listener: _start_resource_monitoring 08:34:52 INFO - Starting resource monitoring. 08:34:52 INFO - ##### 08:34:52 INFO - ##### Finished create-virtualenv step (success) 08:34:52 INFO - ##### 08:34:52 INFO - ##### 08:34:52 INFO - ##### Running install step. 08:34:52 INFO - ##### 08:34:52 INFO - Running pre-action listener: _resource_record_pre_action 08:34:52 INFO - Running main action method: install 08:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:52 INFO - Reading from file tmpfile_stdout 08:34:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:34:52 INFO - Reading from file tmpfile_stdout 08:34:52 INFO - Output received: 08:34:52 INFO - Usage: mozinstall [options] installer 08:34:52 INFO - Options: 08:34:52 INFO - -h, --help show this help message and exit 08:34:52 INFO - -d DEST, --destination=DEST 08:34:52 INFO - Directory to install application into. [default: 08:34:52 INFO - "/builds/slave/test"] 08:34:52 INFO - --app=APP Application being installed. [default: firefox] 08:34:52 INFO - mkdir: /builds/slave/test/build/application 08:34:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:35:08 INFO - Reading from file tmpfile_stdout 08:35:08 INFO - Output received: 08:35:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:35:08 INFO - Running post-action listener: _resource_record_post_action 08:35:08 INFO - ##### 08:35:08 INFO - ##### Finished install step (success) 08:35:08 INFO - ##### 08:35:08 INFO - ##### 08:35:08 INFO - ##### Running run-tests step. 08:35:08 INFO - ##### 08:35:08 INFO - Running pre-action listener: _resource_record_pre_action 08:35:08 INFO - Running main action method: run_tests 08:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:08 INFO - Python 2.7.3 08:35:08 INFO - Return code: 0 08:35:08 INFO - grabbing minidump binary from tooltool 08:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:08 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 0x251c9c0>, '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 0x251d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:35:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:35:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:35:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:08 INFO - Return code: 0 08:35:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:35:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:35:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:35:09 INFO - Return code: 0 08:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:35:09 INFO - Using env: {'DISPLAY': ':0', 08:35:09 INFO - 'HOME': '/home/cltbld', 08:35:09 INFO - 'LANG': 'en_US.UTF-8', 08:35:09 INFO - 'LANGUAGE': 'en_US:en', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MAIL': '/var/mail/cltbld', 08:35:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SHLVL': '1', 08:35:09 INFO - 'TERM': 'linux', 08:35:09 INFO - 'TMOUT': '86400', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464795256.169214-200108303', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - '_': '/tools/buildbot/bin/python'} 08:35:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:35:09 INFO - mozversion application_buildid: 20160601075442 08:35:09 INFO - mozversion application_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 08:35:09 INFO - mozversion application_display_name: Nightly 08:35:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:09 INFO - mozversion application_name: Firefox 08:35:09 INFO - mozversion application_remotingname: firefox 08:35:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:35:09 INFO - mozversion application_vendor: Mozilla 08:35:09 INFO - mozversion application_version: 49.0a1 08:35:09 INFO - mozversion platform_buildid: 20160601075442 08:35:09 INFO - mozversion platform_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 08:35:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:35:09 INFO - mozversion platform_version: 49.0a1 08:35:09 INFO - using testdate: 1464795309 08:35:09 INFO - actual date: 1464795309 08:35:09 INFO - starting webserver on 'localhost:41536' 08:35:09 INFO - SUITE-START | Running 2 tests 08:35:09 INFO - TEST-START | dromaeo_css 08:35:09 INFO - operating with platform_type : linux_ 08:35:09 INFO - Initialising browser for dromaeo_css test... 08:35:09 INFO - TEST-INFO | started process 10262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXIKvaL/profile http://localhost:41536/getInfo.html) 08:35:14 INFO - PROCESS | 10262 | __metrics Screen width/height:1600/1200 08:35:14 INFO - PROCESS | 10262 | colorDepth:24 08:35:14 INFO - PROCESS | 10262 | Browser inner width/height: 1024/697 08:35:14 INFO - PROCESS | 10262 | __metrics 08:35:15 ERROR - PROCESS | 10262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:35:16 INFO - TEST-INFO | 10262: exit 0 08:35:16 INFO - Browser initialized. 08:35:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:16 INFO - TEST-INFO | started process 10379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXIKvaL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:28 INFO - PROCESS | 10379 | RSS: Main: 167833600 08:35:28 INFO - PROCESS | 10379 | 08:36:17 INFO - PROCESS | 10379 | 1464795377748 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:38:29 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41536/tests/dromaeo/cssquery-ext.html) 08:38:30 INFO - PROCESS | 10379 | RSS: Main: 170041344 08:38:30 INFO - PROCESS | 10379 | 08:41:32 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-ext.html (next: http://localhost:41536/tests/dromaeo/cssquery-jquery.html) 08:41:33 INFO - PROCESS | 10379 | RSS: Main: 169136128 08:41:33 INFO - PROCESS | 10379 | 08:44:35 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41536/tests/dromaeo/cssquery-mootools.html) 08:44:35 INFO - PROCESS | 10379 | RSS: Main: 170164224 08:44:35 INFO - PROCESS | 10379 | 08:47:37 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41536/tests/dromaeo/cssquery-prototype.html) 08:47:38 INFO - PROCESS | 10379 | RSS: Main: 168022016 08:47:38 INFO - PROCESS | 10379 | 08:50:40 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41536/tests/dromaeo/cssquery-yui.html) 08:50:41 INFO - PROCESS | 10379 | RSS: Main: 170020864 08:50:41 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:41536/tests/dromaeo/cssquery-yui.html (next: http://localhost:41536/tests/dromaeo/cssquery-dojo.html) 08:53:44 INFO - PROCESS | 10379 | RSS: Main: 170868736 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | __start_tp_report 08:53:44 INFO - PROCESS | 10379 | _x_x_mozilla_page_load 08:53:44 INFO - PROCESS | 10379 | _x_x_mozilla_page_load_details 08:53:44 INFO - PROCESS | 10379 | |i|pagename|runs| 08:53:44 INFO - PROCESS | 10379 | |0;dojo.html;2612.085769980507;2675.6387887635165;2684.43626838364;2687.7177896320886;2691.3002619318972;4612.654050946176;4640.930386044208;4646.954435252071;4718.9854181351;4743.833965811197;4522.321651752239;4661.067786442716;4669.322948172513;4685.8594242172785;4735.692180008297;4279.037216626258;4342.565743425648;4380.802863871133;4408.382826404306;4409.29451287794;634.7179565057043;4201.138766552849;4245.150969806035;4249.043965107857;4272.081502476967;4301.591348821857;4302.225599392108;4306.892327691801;4314.309710446345;4321.848735294249;4338.089001309729;4361.694681372305;4369.847055353079;4375.7593332366705;4421.801018954155;4194.2869712149;4325.221460137174;4328.826846926119;4331.090471001094;4383.75889326087;4503.347014682852;4570.680052396334;4573.839915602971;4617.515160908123;4625.468071171825;4951.851444456672;5017.147084995559;5033.219850923113;5036.244563315496;5044.54599086084;4941.901161976776;5021.17150670139;5051.848444546669;5104.770285337168;5118.488151184889;4744.454387745419;4748.715077095385;4754.881127971828;4758.524147585248;4785.688930219525;5155;5176.8964620707375;5183.3261675981885;5189.351331083614;5225.790968361299;4864.732439715779;4873.342098816614;4922.360093187935;4927.1131196384995;5011.198208286657;4977.303177555145;5030.647854650212;5050.090983622983;5058.772355244023;5093.032323858455;4929.605631549467;4980.576650984634;4992.276119962585;5004.324416203839;5047.772850221749;4878.487758785347;4923.729194894244;4947.851564453073;4975.228839529878;4977.377827771528;4331.501877284152;4354.804033818486;4359.17175736609;4370;4406.581374769392;3718.2935242303874;3788.299164654548;3790.6209379061875;3794.165283637595;3848.9807550962064;4247.830086796555;4332.761698106634;4354.172707185625;4366.345048242725;4391.582799634093;4965;4968.701877887338;4977.850664480072;4987.725675087905;5002.924956125661;4368.453943257093;4377.9124417511475;4395.428594282723;4402.3176407656865;4414.690971631955;4478.820847166076;4488.820447182076;4493.191225579361;4501.617362524222;4579.290210017386;4689.343491911135;4731.597814185764;4741.810327586858;4753.548412900769;4759.428868535798;5045.84862454127;5090.796368145233;5105.106606343801;5107.463716309882;5133.153029750049;4608.723476591415;4719.764011799465;4753.619710423227;4753.738544380092;4802.567768900815;4926.778294976663;4942.159832828356;4950.554450099508;4964.982178653439;5008.899822003613;4982.676126051795;4996.15065438869;5033.2701758245585;5036.949630503648;5084.906745049684;4808.975955120202;4854.78153483087;4875.902481950412;4887.0714564232685;4928.630352723631;4791.520847915181;4843.1524483216;4849.927251091307;4920.778564964514;4923.990581930624;4826.613870890391;4829.082474329866;4837.346958160603;4846.830360937492;4875.561199492063;4931.753412329441;4937.728424936519;4938.555530002317;4952;4994.150994331045;4804.351412559399;4804.903901922012;4816.301636262652;4819.180739274261;4821.373221481185 08:53:44 INFO - PROCESS | 10379 | |1;ext.html;541.756307451594;587.1075964533909;590.0500194686557;603.7977277611999;624.5565648389643;33365.66634333656;37829.810850945774;37853.621463785355;37916.241675166515;37943.4308485373;38800.80599596998;39059.80470097653;39240.80379598105;39269.8036509817;39299.607003930025;7554.282343177403;7623.23767623236;7631.961840190819;7646.808829779245;7666.156722760492;7564.848703025937;7658.234176582353;7708.768736937901;7711.3059824615775;7721.691132354727;7688.769336919901;7727.574983375912;7733.342665873408;7744.303012728853;7749.496282741604;7599.354054905312;7638.5798781067015;7653.081630204383;7702.07575090987;7705.768826935201;7630.122535908386;7677.577733224671;7696.345810606105;7697.961510192469;7709.267619576188;36775.4483682745;37184;37252.25495490102;37289.25421491555;37378.626213737785;2974.3753811699353;3132.1386618679817;3441.7246620270316;3697.2051009032916;3811;29340.413191736046;29344;30046.098617041524;30095.398092038038;30749.38501229963;3275.9516954574547;3327.617324007746;3332.283559034795;3341.214814518586;3373.241020770307;173605;174324;174405;174440;240615.99999999825;33213.50179747306;52487.475125249024;52727.20909186288;52973.47026529763;53009.734951324994;34370.312593747985;34388.48417273743;34417.65582344145;34522.30955380928;34646.65353346484;13403.597892063253;13643.727125457435;13674.521391751241;13721;13724.382402791898;11238.157138214667;11241.831372529256;11275.887241127484;11314;11316.755156932732;7907.525548466995;7923;7938.364930805522;7953.403494737802;7961.164077771867;3145;3183.2201110727556;3192.281736609291;3212.37358715053;3217.613886333655;859.656137544987;860.2472836268265;974.780674348266;988.4909271725068;1013.1540163963173;27633.723662763517;28663;28666.856665716954;28866.567001494994;29091.85454072716;970.5050424283667;1027.1833892055834;1036.43514284715;1037.9273450858368;1099.1591432554103;14571.41714331436;14579.41682332716;14586.4894728684;15160;15209.467668631545;371943;372233;372674;376719;377009;49110.508894911305;49990.25014624783;50036;50134.74932625386;50177.24734128991;1183.8638556566104;1191.386435985468;1192.6362459449776;1193.8925496705165;1213.1992884696058;26475.735242648097;26987.59518607183;27564.448711025267;27697.169084927486;29082.41835163327;47907;48591;48715;48736;48766.26850597315;349182;349508;351906;352413;352903;38487.807560962014;38744.03139921412;39355.6064439352;39508.40737388999;39819;43021.35467968046;43551.78224108859;43600.12799743924;43803.12393752171;44268;36590.26819463649;37048.81475592605;37056.25887482181;37236.255274894895;37753.62246377501;37221.627783721815;37334.43998339973;37338;37484.81257593694;38065.42901856419;31223.843880780452;35679;36280;36603.45094823633;36856.63143368532;32034.51948220732;33330.666693333726;33371.332573347914;33775.49336759902;33841.3231735359;25573;25970.87014564915;26060.34849128787;26166.86916565405;26217.737822622294 08:53:44 INFO - PROCESS | 10379 | |2;jquery.html;363.5746176972943;365.97621154624954;368.462045413696;374.5486240816835;375.4499658001028;15311.770323445156;16201.351945922164;16902.83097169028;17019.57451063721;17020.404285849996;16018.919905400457;16361;16980;17092.974421534716;17102.572435689115;4855.490173531782;4973.5772459341;5018.272350509174;5033.748312584375;5036.672616279949;3686.981565092184;4875.414950205963;5550.47270509303;5778.3643799182055;5814.447627475383;5861.3552509223955;5868.03177475716;5890.234269544953;5902.203202567642;5916.822495325126;5667.263255776743;5800.738966746507;5851.502622277111;5887.264091988502;5891.086881533369;4918.262260660929;5069.822556210515;5095.133827249377;5097.643164978453;5113.156329205676;20004.199832006703;20035.699464508045;20196.49508762278;20222.09000594962;20520.281790137422;1852.1757817771097;1884.5759704066475;1890.8392786613153;1974.3188599933;2059.660156074246;12854.935725321313;13325.733485330336;13450.12574182675;13573.796393054112;13610.115342502804;1766.567191038191;1772.831580999803;1778.1287169287086;1818.8181181881705;1856.8421684156729;63778.3622163777;67316;67344.66327668379;67596.6620166901;68508.6574567124;9027.187553120251;9089.95455022734;9493.620255189715;9535.666251681158;9631.036896310314;12740.617781466572;12781.61655150347;12848.164869283466;12857.357132143356;12861.228326300452;6811.148606424197;6875.209350924708;6935.445164386837;7018.122734658168;7039.084918960502;6531.477481801445;6584.868302634016;6745.662716864235;6749.122614060141;6759.188897332253;5654.293213348332;5780.011791863601;5842.386549412336;5860.882782344414;6000.519958403317;1590.721623715845;1665.7418100194488;1678.6055277009893;1760.4542591796328;1804.3414153833755;851.9914800852036;874.7856775090144;886.5965985476722;917.3257655623112;1020.2756043209405;15947;16474.58813529671;16698.58253543671;16774.161291935354;16884.155792210342;865.3769286113987;867.2844902955087;886.2378354615026;904.0778406025817;938.7230766923637;9424.434533927986;9625.085616866387;9719.708408747749;9815.705528834147;9944.204463642891;377787;381279;383009;422361;428525;48808.26787598189;50918.745406272734;75968;77649.61175194087;85662.14337856666;928.0858354520792;928.2434815625379;967.4002118686459;970.427447805798;974.0503009565758;15103;15141.848581514043;15169.165695886832;15266.465673701367;15723.528294151194;33803.323933521686;34783.13042173966;34903.650963491054;35084.824575876955;35766.463503048;44638.77680611576;46181.538184617726;50408;50932.49067509278;50945;4652.162610730101;5566.387697353207;6950.826229344307;7204.855902881808;7310.96344518274;9485.810283794148;10197;10471.418651933396;10675.412852293199;10732.409717465614;6690;8930.330225233003;9149.130832570896;9318.347715659838;9548.283878709264;8872;8880;9211.170994610517;9281.67514137002;9372.484513351832;9144.050521603496;9150.267978561833;9446.527673616154;9496.382735122195;9771.364861283993;7060.752873649398;7132.643367831484;7214.6392680364725;7226.060612120391;7299.927000729925;8727.91272087271;8980.236679882284;9299.116583924517;9557.856632150384;9846.704598862045 08:53:44 INFO - PROCESS | 10379 | |3;mootools.html;1387.5282403982646;1425.365712258045;1505.4881340344282;1702.7956645202578;1704.233095107202;6652.866942661144;7362.300581444761;7377.778666639996;7854;7952.920470795298;7564.319211270985;7626.351760100384;7646.808829779258;7656.846863062749;7788.104367997682;2172.6849606806963;2217.2572188316935;2220.200727738013;2221.311393468022;2226.866388016716;2168.739751229855;2190.266260802625;2209.801117899389;2218.8557743746687;2219.289827255279;2169.620316444616;2177.346795961213;2187.704659870913;2200.0759680933966;2230.230570453199;2102.2221777942104;2104.389726979182;2105.463106907744;2153.5154590217235;2186.256672731279;2109.135254545629;2122.193566444741;2126.6384714598403;2138.6898899659463;2149.387424583986;7699.615019249071;7709.575973321465;7727;7730.845383092363;7779.72770953014;4544.772761361952;4654.371659825948;4656.022235330584;4656.41794775653;4672.462666793328;2735.275152084699;2842.204182828811;2860.2134413036374;2866.971330286691;2869.7704183665255;908.1145882764318;959.7696552827341;965.4062751407904;976.8778902637171;979.2019504104132;10295.279330446872;10413.635522756744;10449.79100417995;10603.257771955967;10621.522031508523;4267.1892340455215;4284.271673815459;4363.716358436692;4372.453443319585;4376.102898905717;8942.46345219289;8965.058668839809;8983.640654373883;9087.318451116193;9089.454632722058;4592.7933243004145;4615.746133962597;4633.4671512775785;4648.814047438064;4662.370579971661;3723.1809002019513;3868.845246190121;4020.6381425671243;4180.101278225196;4248.044190057212;3631.6368363163474;3716.4053751399647;3748.3065632857465;3780.8487660493274;3803.1252811852873;1156.5605070073486;1209.504103317653;1217.6773155113901;1227.699213692651;1238.6903274181454;827.4332082523491;839.2824135364298;850.9702160424356;868.68727258187;874.9518776467355;5075.644704870698;5199.246109314128;5199.272101905736;5210.843674689765;5329.600279978939;414.678624066351;432.5695932547136;434.20323705999846;439.93181056936226;440.06047089464226;3553.875614353537;3624.6919011883756;3658.34149853029;3680.6687398134295;3709.4435834625024;9199.724008279762;9329.207017403596;9341.766455838522;9425.340226184102;9434.48110353937;9238.815223695488;9342.626294948126;9365.391249568756;9414.95292523533;9539.379940303857;7168.856622867514;7180.533265337736;7187.9640601796655;7193.568385896968;7246.96376518114;5063.594912406925;5112.590992720648;5126.4617215191865;5360.035193665021;5370.275012873212;8724.825503489768;8743;8758.693445729368;8795.296376290009;8901.465912045298;8249.670013199404;8495.957520212607;8517.190866867637;8814.955925220589;8912.73261802147;5803.47768700819;6076.513878889767;6144.446999770043;6607.372299631527;6747.257801641717;6980.406665433495;6982.965085174745;6998.6850591724515;7007.649617519001;7028.472864535078;6204.658743769136;6393.744250229939;6401.199850018747;6429.4534964526665;6463.7737679181;6328.303886572566;6456.160699109086;6551.344865513411;6604.240512341143;6703.363180497845;6125.877482450237;6126.08108783686;6145.4161854623735;6183.752649893954;6213.37866213375;4553.886152846206;4571.3371561122785;4593.494715581351;4600.516945720651;4604.1252162089095;4510.210713125124;4554.0664163847;4559.156556037144;4563.475200352002;4584.679072464895 08:53:44 INFO - PROCESS | 10379 | |4;prototype.html;301.4047256668081;302.84403532180926;308.87490566320633;312.20232306456995;312.431374897686;4953.801847926087;4996.851983250556;5009.524095210953;5049.495050494948;5079.695218286901;4923.926141107877;4957.677750946186;4962.528559786823;4972.552470277675;4987.501249875011;3690.1697118148472;3784.3944968804994;3938.8424463021443;3941.8423263069444;3948.1708841143395;3899.317619416605;3921.450996860442;3935.822887970048;3958.1885713428824;3962.6433620974108;3940.743851649648;3951.2097580483874;3960.3069462844032;3970.1067259866445;3977.82099805508;3838.7120965927666;3841.1741475582603;3901.4928059352387;3960.9801950990204;3967.2660557796758;3443.5867695876404;3467.133216695826;3469.9479507807405;3472.871316822043;3473.930521389583;4746.240601503743;4748.928766068511;4760.666753327268;4779.402574678165;4781.713097214143;4396.78016099197;4477.529859364785;4503.909921801578;4516.458025037016;4526.864194074183;5221.269022336875;5221.321228240305;5236.92144617831;5239.502247286502;5257.7108259045735;3797.620237976208;3806.695464362844;3806.7144964127524;3809.5238095238096;3824.694024478035;5261.421573527965;5478.808241711561;5489.176623506466;5512.862178445531;5548.833534993957;3894.5131858517684;3900.91301153887;3902.8829135125993;3913.726039177287;3923.0388554803685;3905.4337121117846;3924.4898163238595;3930.6855451563806;3944.6647035002347;3960.20795840833;4385.736855788663;4425.867223983286;4452.220861349251;4464.397306363664;4468.419105516262;4944.330061766677;5194.974025129925;5206.609504287194;5221.295125158055;5298.390685071189;1326.4495234477777;1340.1021315718492;1341.872522110398;1345.8519562848078;1350.9729805403838;824.9752507424787;835.8202986357962;853.8643604006656;871.0810095349341;871.7166920750782;4538.591526762607;4596.7931443085145;4597.586217240464;4639.164950308909;4644.58198762113;5384.542313903284;5385.353757549041;5401.513863752281;5409.891802163935;5411.83764487066;4512.165249428866;4628.83799067031;4634.490206077328;4651.720896746206;4659.603933665677;2828.5050116229577;2879.2226098953583;2891.493988551995;2894.9276268093467;2923.137674386061;5070.112730272188;5081.5426611605135;5088.77100530477;5096.745162741922;5114.769835357418;5424.83725488236;5539.556835453154;5557.638753481011;5602.551795856321;5634.267545219095;5082.364704411949;5084.5932325414615;5099.923501147486;5116.9744151279;5129.820456284012;5393.298871146726;5412.621116521806;5425.864353391039;5457.181422786613;5469.75386107634;5021.221710634857;5301.443348448357;5327.629205003736;5341.919871201857;5377.924415116914;5114.514121158632;5121.180611102206;5146.6911985281;5154.896902061862;5162.199859021857;3784.5836957934052;3806.219724956322;3818.8472461101246;3823.5602905666206;3828.7173796778393;5108;5355.2234925934745;5374.946250537445;5381.919271210857;5466.04833389965;5159.226116082617;5162.793488260578;5174.560162386088;5178.119719647593;5204.479552044765;5208.4270730220405;5215.81744638951;5228.607854410859;5235;5239.842804715865;4977.527134922177;5159.684280508446;5164.354455693038;5170.922436163536;5175.654329874184;5026.623003274842;5140;5218.834183813827;5246.895062098661;5268;5135.972805439002;5182.792688292426;5191.195364718475;5209.395302348826;5225.268462415189 08:53:44 INFO - PROCESS | 10379 | |5;yui.html;602.5902386377264;644.2719726708818;644.6325594411187;653.9607623542588;656.1961597043619;10412.791744165123;10719.35683858969;10865.945670271658;10878.347299162057;10948.835767463484;11296.209265351428;11356.205065645387;11380.658580242585;11404.771904561903;11408.20142590017;628.4406877878691;769.2845653542204;783.5024759277857;789.5341748368461;799.8640231160688;782.62042909189;785.0540099180503;785.8821176823465;787.3583029830698;788.5268838696765;826.6734639817269;828.0394742099166;829.0383155539575;831.71721614651;831.7296878514477;822.9465084769471;823.6664151018817;828.1470085811624;828.4076885027174;828.6933834481281;606.1574411567924;606.3421188011014;606.754264522869;606.9817905462843;607.168179593959;11451.94274028633;11497.712557186054;11499.540018399337;11504.079673626173;11554.480048397842;10987.890121098766;11107.222494425394;11192.552297908074;11238.943805280922;11311.936573773137;9431.717048488556;9478.810423791554;9570.282228832866;9595.328327017112;9740.805183896353;2993.4013197360614;3054.8167109973474;3088.737457316131;3097.9690203097907;3141.984290078535;42949.57050429487;43587.34618980718;43817.561824381664;43869.341959870624;44943.32585011228;9058;9198.356115071882;9207.309451791143;9275.95362023199;9291.814163716688;17180.140992950302;17187.828121718623;17201.655966880593;17208.82791172097;17221.56946076358;6357.078223657544;6413.16628838248;6474.611523308617;6483.124778154889;6490.286068532458;3453.8791142309897;3492.8253587320532;3518;3588.7129029677562;3589.10272431892;2646.7617914387797;2772.7365900239447;2775.139706690932;2822.971770282271;2840.233137052984;552.0918089742352;552.8942115768463;552.9861753456196;563.2143160291371;569.9458551437607;520.9088409528317;606.6329870428416;618.3476432363809;622.4273668225244;627.8367624417593;7707.190744971809;7780.416468764865;7914.592157737035;8102.351811855037;8111.9594402027615;557.8995780759421;590.8375196820823;613.7667686279185;625.4183609243447;638.7923924724483;3632.8183590820354;3718.442233664972;3721.5162028936065;3796.6393192646656;3879.1853710721066;51546.74226628843;52907.735461322445;53043.734781325846;53211.73394133004;53489;46728.766356168;47851.52148478471;48478.5152148474;48636.27045594319;49099.509004909494;29140.854295728386;44312.335314969656;46378.76810615993;46455;47694.52305476901;8093.109757926505;8175.1416101308505;8225.506469611842;8240.340772738047;8364.916350836414;30788;30899.536506951965;30977;31012.53481197829;31496.37007259888;37262.44106338353;40591.18817623572;40721;41004.384934226604;41170.38244426396;10004.521761598862;10090.09189172978;10191.847122293024;10290.845637315597;10354.637587684696;10574.524146413276;10846.132309415385;11245.38150401703;11398;11907.642770716893;10732.248742587944;10774.191935605018;10789.082927950898;11499.54001839917;11623.59317423886;10851.511681974487;11088.66733997949;11185;11198.38408887519;11219.7756044877;9866.358686685342;10128.493575321352;10337.638182663572;10454.477276136315;11193.328400296008;8844.823103538021;8920.955395223242;8959.910400895908;8965.327600430124;9158.95420522893;8770.210681038738;8903.243224326005;9074.546272686472;9406.529673516434;9519.524023798644 08:53:44 INFO - PROCESS | 10379 | __end_tp_report 08:53:44 INFO - PROCESS | 10379 | __start_cc_report 08:53:44 INFO - PROCESS | 10379 | _x_x_mozilla_cycle_collect,368 08:53:44 INFO - PROCESS | 10379 | __end_cc_report 08:53:44 INFO - PROCESS | 10379 | __startTimestamp1464796424278__endTimestamp 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | ------- Summary: start ------- 08:53:44 INFO - PROCESS | 10379 | Number of tests: 6 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#0] dojo.html Cycles:165 Average:4624.79 Median:4785.69 stddev:566.76 (11.8%) stddev-sans-first:546.07 08:53:44 INFO - PROCESS | 10379 | Values: 2612.1 2675.6 2684.4 2687.7 2691.3 4612.7 4640.9 4647.0 4719.0 4743.8 4522.3 4661.1 4669.3 4685.9 4735.7 4279.0 4342.6 4380.8 4408.4 4409.3 634.7 4201.1 4245.2 4249.0 4272.1 4301.6 4302.2 4306.9 4314.3 4321.8 4338.1 4361.7 4369.8 4375.8 4421.8 4194.3 4325.2 4328.8 4331.1 4383.8 4503.3 4570.7 4573.8 4617.5 4625.5 4951.9 5017.1 5033.2 5036.2 5044.5 4941.9 5021.2 5051.8 5104.8 5118.5 4744.5 4748.7 4754.9 4758.5 4785.7 5155.0 5176.9 5183.3 5189.4 5225.8 4864.7 4873.3 4922.4 4927.1 5011.2 4977.3 5030.6 5050.1 5058.8 5093.0 4929.6 4980.6 4992.3 5004.3 5047.8 4878.5 4923.7 4947.9 4975.2 4977.4 4331.5 4354.8 4359.2 4370.0 4406.6 3718.3 3788.3 3790.6 3794.2 3849.0 4247.8 4332.8 4354.2 4366.3 4391.6 4965.0 4968.7 4977.9 4987.7 5002.9 4368.5 4377.9 4395.4 4402.3 4414.7 4478.8 4488.8 4493.2 4501.6 4579.3 4689.3 4731.6 4741.8 4753.5 4759.4 5045.8 5090.8 5105.1 5107.5 5133.2 4608.7 4719.8 4753.6 4753.7 4802.6 4926.8 4942.2 4950.6 4965.0 5008.9 4982.7 4996.2 5033.3 5036.9 5084.9 4809.0 4854.8 4875.9 4887.1 4928.6 4791.5 4843.2 4849.9 4920.8 4924.0 4826.6 4829.1 4837.3 4846.8 4875.6 4931.8 4937.7 4938.6 4952.0 4994.2 4804.4 4804.9 4816.3 4819.2 4821.4 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#1] ext.html Cycles:180 Average:45713.73 Median:204563.50 stddev:83457.56 (40.8%) stddev-sans-first:83622.76 08:53:44 INFO - PROCESS | 10379 | Values: 541.8 587.1 590.1 603.8 624.6 33365.7 37829.8 37853.6 37916.2 37943.4 38800.8 39059.8 39240.8 39269.8 39299.6 7554.3 7623.2 7632.0 7646.8 7666.2 7564.8 7658.2 7708.8 7711.3 7721.7 7688.8 7727.6 7733.3 7744.3 7749.5 7599.4 7638.6 7653.1 7702.1 7705.8 7630.1 7677.6 7696.3 7698.0 7709.3 36775.4 37184.0 37252.3 37289.3 37378.6 2974.4 3132.1 3441.7 3697.2 3811.0 29340.4 29344.0 30046.1 30095.4 30749.4 3276.0 3327.6 3332.3 3341.2 3373.2 173605.0 174324.0 174405.0 174440.0 240616.0 33213.5 52487.5 52727.2 52973.5 53009.7 34370.3 34388.5 34417.7 34522.3 34646.7 13403.6 13643.7 13674.5 13721.0 13724.4 11238.2 11241.8 11275.9 11314.0 11316.8 7907.5 7923.0 7938.4 7953.4 7961.2 3145.0 3183.2 3192.3 3212.4 3217.6 859.7 860.2 974.8 988.5 1013.2 27633.7 28663.0 28666.9 28866.6 29091.9 970.5 1027.2 1036.4 1037.9 1099.2 14571.4 14579.4 14586.5 15160.0 15209.5 371943.0 372233.0 372674.0 376719.0 377009.0 49110.5 49990.3 50036.0 50134.7 50177.2 1183.9 1191.4 1192.6 1193.9 1213.2 26475.7 26987.6 27564.4 27697.2 29082.4 47907.0 48591.0 48715.0 48736.0 48766.3 349182.0 349508.0 351906.0 352413.0 352903.0 38487.8 38744.0 39355.6 39508.4 39819.0 43021.4 43551.8 43600.1 43803.1 44268.0 36590.3 37048.8 37056.3 37236.3 37753.6 37221.6 37334.4 37338.0 37484.8 38065.4 31223.8 35679.0 36280.0 36603.5 36856.6 32034.5 33330.7 33371.3 33775.5 33841.3 25573.0 25970.9 26060.3 26166.9 26217.7 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#2] jquery.html Cycles:180 Average:23959.01 Median:5558.43 stddev:65672.19 (1181.5%) stddev-sans-first:65832.52 08:53:44 INFO - PROCESS | 10379 | Values: 363.6 366.0 368.5 374.5 375.4 15311.8 16201.4 16902.8 17019.6 17020.4 16018.9 16361.0 16980.0 17093.0 17102.6 4855.5 4973.6 5018.3 5033.7 5036.7 3687.0 4875.4 5550.5 5778.4 5814.4 5861.4 5868.0 5890.2 5902.2 5916.8 5667.3 5800.7 5851.5 5887.3 5891.1 4918.3 5069.8 5095.1 5097.6 5113.2 20004.2 20035.7 20196.5 20222.1 20520.3 1852.2 1884.6 1890.8 1974.3 2059.7 12854.9 13325.7 13450.1 13573.8 13610.1 1766.6 1772.8 1778.1 1818.8 1856.8 63778.4 67316.0 67344.7 67596.7 68508.7 9027.2 9090.0 9493.6 9535.7 9631.0 12740.6 12781.6 12848.2 12857.4 12861.2 6811.1 6875.2 6935.4 7018.1 7039.1 6531.5 6584.9 6745.7 6749.1 6759.2 5654.3 5780.0 5842.4 5860.9 6000.5 1590.7 1665.7 1678.6 1760.5 1804.3 852.0 874.8 886.6 917.3 1020.3 15947.0 16474.6 16698.6 16774.2 16884.2 865.4 867.3 886.2 904.1 938.7 9424.4 9625.1 9719.7 9815.7 9944.2 377787.0 381279.0 383009.0 422361.0 428525.0 48808.3 50918.7 75968.0 77649.6 85662.1 928.1 928.2 967.4 970.4 974.1 15103.0 15141.8 15169.2 15266.5 15723.5 33803.3 34783.1 34903.7 35084.8 35766.5 44638.8 46181.5 50408.0 50932.5 50945.0 4652.2 5566.4 6950.8 7204.9 7311.0 9485.8 10197.0 10471.4 10675.4 10732.4 6690.0 8930.3 9149.1 9318.3 9548.3 8872.0 8880.0 9211.2 9281.7 9372.5 9144.1 9150.3 9446.5 9496.4 9771.4 7060.8 7132.6 7214.6 7226.1 7299.9 8727.9 8980.2 9299.1 9557.9 9846.7 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#3] mootools.html Cycles:180 Average:5033.30 Median:5069.62 stddev:2793.65 (55.1%) stddev-sans-first:2788.05 08:53:44 INFO - PROCESS | 10379 | Values: 1387.5 1425.4 1505.5 1702.8 1704.2 6652.9 7362.3 7377.8 7854.0 7952.9 7564.3 7626.4 7646.8 7656.8 7788.1 2172.7 2217.3 2220.2 2221.3 2226.9 2168.7 2190.3 2209.8 2218.9 2219.3 2169.6 2177.3 2187.7 2200.1 2230.2 2102.2 2104.4 2105.5 2153.5 2186.3 2109.1 2122.2 2126.6 2138.7 2149.4 7699.6 7709.6 7727.0 7730.8 7779.7 4544.8 4654.4 4656.0 4656.4 4672.5 2735.3 2842.2 2860.2 2867.0 2869.8 908.1 959.8 965.4 976.9 979.2 10295.3 10413.6 10449.8 10603.3 10621.5 4267.2 4284.3 4363.7 4372.5 4376.1 8942.5 8965.1 8983.6 9087.3 9089.5 4592.8 4615.7 4633.5 4648.8 4662.4 3723.2 3868.8 4020.6 4180.1 4248.0 3631.6 3716.4 3748.3 3780.8 3803.1 1156.6 1209.5 1217.7 1227.7 1238.7 827.4 839.3 851.0 868.7 875.0 5075.6 5199.2 5199.3 5210.8 5329.6 414.7 432.6 434.2 439.9 440.1 3553.9 3624.7 3658.3 3680.7 3709.4 9199.7 9329.2 9341.8 9425.3 9434.5 9238.8 9342.6 9365.4 9415.0 9539.4 7168.9 7180.5 7188.0 7193.6 7247.0 5063.6 5112.6 5126.5 5360.0 5370.3 8724.8 8743.0 8758.7 8795.3 8901.5 8249.7 8496.0 8517.2 8815.0 8912.7 5803.5 6076.5 6144.4 6607.4 6747.3 6980.4 6983.0 6998.7 7007.6 7028.5 6204.7 6393.7 6401.2 6429.5 6463.8 6328.3 6456.2 6551.3 6604.2 6703.4 6125.9 6126.1 6145.4 6183.8 6213.4 4553.9 4571.3 4593.5 4600.5 4604.1 4510.2 4554.1 4559.2 4563.5 4584.7 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#4] prototype.html Cycles:180 Average:4359.67 Median:4975.04 stddev:1261.34 (25.4%) stddev-sans-first:1227.55 08:53:44 INFO - PROCESS | 10379 | Values: 301.4 302.8 308.9 312.2 312.4 4953.8 4996.9 5009.5 5049.5 5079.7 4923.9 4957.7 4962.5 4972.6 4987.5 3690.2 3784.4 3938.8 3941.8 3948.2 3899.3 3921.5 3935.8 3958.2 3962.6 3940.7 3951.2 3960.3 3970.1 3977.8 3838.7 3841.2 3901.5 3961.0 3967.3 3443.6 3467.1 3469.9 3472.9 3473.9 4746.2 4748.9 4760.7 4779.4 4781.7 4396.8 4477.5 4503.9 4516.5 4526.9 5221.3 5221.3 5236.9 5239.5 5257.7 3797.6 3806.7 3806.7 3809.5 3824.7 5261.4 5478.8 5489.2 5512.9 5548.8 3894.5 3900.9 3902.9 3913.7 3923.0 3905.4 3924.5 3930.7 3944.7 3960.2 4385.7 4425.9 4452.2 4464.4 4468.4 4944.3 5195.0 5206.6 5221.3 5298.4 1326.4 1340.1 1341.9 1345.9 1351.0 825.0 835.8 853.9 871.1 871.7 4538.6 4596.8 4597.6 4639.2 4644.6 5384.5 5385.4 5401.5 5409.9 5411.8 4512.2 4628.8 4634.5 4651.7 4659.6 2828.5 2879.2 2891.5 2894.9 2923.1 5070.1 5081.5 5088.8 5096.7 5114.8 5424.8 5539.6 5557.6 5602.6 5634.3 5082.4 5084.6 5099.9 5117.0 5129.8 5393.3 5412.6 5425.9 5457.2 5469.8 5021.2 5301.4 5327.6 5341.9 5377.9 5114.5 5121.2 5146.7 5154.9 5162.2 3784.6 3806.2 3818.8 3823.6 3828.7 5108.0 5355.2 5374.9 5381.9 5466.0 5159.2 5162.8 5174.6 5178.1 5204.5 5208.4 5215.8 5228.6 5235.0 5239.8 4977.5 5159.7 5164.4 5170.9 5175.7 5026.6 5140.0 5218.8 5246.9 5268.0 5136.0 5182.8 5191.2 5209.4 5225.3 08:53:44 INFO - PROCESS | 10379 | 08:53:44 INFO - PROCESS | 10379 | [#5] yui.html Cycles:180 Average:12599.38 Median:48165.02 stddev:14683.18 (30.5%) stddev-sans-first:14696.73 08:53:44 INFO - PROCESS | 10379 | Values: 602.6 644.3 644.6 654.0 656.2 10412.8 10719.4 10865.9 10878.3 10948.8 11296.2 11356.2 11380.7 11404.8 11408.2 628.4 769.3 783.5 789.5 799.9 782.6 785.1 785.9 787.4 788.5 826.7 828.0 829.0 831.7 831.7 822.9 823.7 828.1 828.4 828.7 606.2 606.3 606.8 607.0 607.2 11451.9 11497.7 11499.5 11504.1 11554.5 10987.9 11107.2 11192.6 11238.9 11311.9 9431.7 9478.8 9570.3 9595.3 9740.8 2993.4 3054.8 3088.7 3098.0 3142.0 42949.6 43587.3 43817.6 43869.3 44943.3 9058.0 9198.4 9207.3 9276.0 9291.8 17180.1 17187.8 17201.7 17208.8 17221.6 6357.1 6413.2 6474.6 6483.1 6490.3 3453.9 3492.8 3518.0 3588.7 3589.1 2646.8 2772.7 2775.1 2823.0 2840.2 552.1 552.9 553.0 563.2 569.9 520.9 606.6 618.3 622.4 627.8 7707.2 7780.4 7914.6 8102.4 8112.0 557.9 590.8 613.8 625.4 638.8 3632.8 3718.4 3721.5 3796.6 3879.2 51546.7 52907.7 53043.7 53211.7 53489.0 46728.8 47851.5 48478.5 48636.3 49099.5 29140.9 44312.3 46378.8 46455.0 47694.5 8093.1 8175.1 8225.5 8240.3 8364.9 30788.0 30899.5 30977.0 31012.5 31496.4 37262.4 40591.2 40721.0 41004.4 41170.4 10004.5 10090.1 10191.8 10290.8 10354.6 10574.5 10846.1 11245.4 11398.0 11907.6 10732.2 10774.2 10789.1 11499.5 11623.6 10851.5 11088.7 11185.0 11198.4 11219.8 9866.4 10128.5 10337.6 10454.5 11193.3 8844.8 8921.0 8959.9 8965.3 9159.0 8770.2 8903.2 9074.5 9406.5 9519.5 08:53:44 INFO - PROCESS | 10379 | -------- Summary: end -------- 08:53:44 INFO - PROCESS | 10379 | 08:53:45 INFO - TEST-INFO | 10379: exit 0 08:53:45 INFO - TEST-OK | dromaeo_css | took 1115356ms 08:53:45 INFO - TEST-START | kraken 08:53:45 INFO - operating with platform_type : linux_ 08:53:45 INFO - Initialising browser for kraken test... 08:53:45 INFO - TEST-INFO | started process 10608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2AlsY/profile http://localhost:41536/getInfo.html) 08:53:49 INFO - PROCESS | 10608 | __metrics Screen width/height:1600/1200 08:53:49 INFO - PROCESS | 10608 | colorDepth:24 08:53:49 INFO - PROCESS | 10608 | Browser inner width/height: 1024/697 08:53:49 INFO - PROCESS | 10608 | __metrics 08:53:50 ERROR - PROCESS | 10608 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:53:51 INFO - TEST-INFO | 10608: exit 0 08:53:51 INFO - Browser initialized. 08:53:51 INFO - Running cycle 1/1 for kraken test... 08:53:51 INFO - TEST-INFO | started process 10726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2AlsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:03 INFO - PROCESS | 10726 | RSS: Main: 167845888 08:54:03 INFO - PROCESS | 10726 | 08:54:06 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41536/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:07 INFO - PROCESS | 10726 | RSS: Main: 173424640 08:54:07 INFO - PROCESS | 10726 | 08:54:09 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41536/tests/kraken/driver.html?testName=audio-dft) 08:54:10 INFO - PROCESS | 10726 | RSS: Main: 173027328 08:54:10 INFO - PROCESS | 10726 | 08:54:13 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41536/tests/kraken/driver.html?testName=audio-fft) 08:54:14 INFO - PROCESS | 10726 | RSS: Main: 168185856 08:54:14 INFO - PROCESS | 10726 | 08:54:16 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41536/tests/kraken/driver.html?testName=audio-oscillator) 08:54:16 INFO - PROCESS | 10726 | RSS: Main: 168632320 08:54:16 INFO - PROCESS | 10726 | 08:54:19 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:19 INFO - PROCESS | 10726 | RSS: Main: 168673280 08:54:19 INFO - PROCESS | 10726 | 08:54:22 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41536/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:23 INFO - PROCESS | 10726 | RSS: Main: 169181184 08:54:23 INFO - PROCESS | 10726 | 08:54:27 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41536/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:27 INFO - PROCESS | 10726 | RSS: Main: 166715392 08:54:27 INFO - PROCESS | 10726 | 08:54:30 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41536/tests/kraken/driver.html?testName=json-parse-financial) 08:54:31 INFO - PROCESS | 10726 | RSS: Main: 167772160 08:54:31 INFO - PROCESS | 10726 | 08:54:32 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:54:33 INFO - PROCESS | 10726 | RSS: Main: 168026112 08:54:33 INFO - PROCESS | 10726 | 08:54:35 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:54:36 INFO - PROCESS | 10726 | RSS: Main: 168116224 08:54:36 INFO - PROCESS | 10726 | 08:54:38 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:54:39 INFO - PROCESS | 10726 | RSS: Main: 168300544 08:54:39 INFO - PROCESS | 10726 | 08:54:41 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:54:42 INFO - PROCESS | 10726 | RSS: Main: 168677376 08:54:42 INFO - PROCESS | 10726 | 08:54:45 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:54:46 INFO - PROCESS | 10726 | RSS: Main: 168472576 08:54:46 INFO - PROCESS | 10726 | 08:54:47 INFO - PROCESS | 10726 | Cycle 1(1): loaded http://localhost:41536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41536/tests/kraken/driver.html?testName=ai-astar) 08:54:48 INFO - PROCESS | 10726 | RSS: Main: 169103360 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | __start_tp_report 08:54:48 INFO - PROCESS | 10726 | _x_x_mozilla_page_load 08:54:48 INFO - PROCESS | 10726 | _x_x_mozilla_page_load_details 08:54:48 INFO - PROCESS | 10726 | |i|pagename|runs| 08:54:48 INFO - PROCESS | 10726 | |0;ai-astar;114;108;113;114;115;114;113;113;115;112 08:54:48 INFO - PROCESS | 10726 | |1;audio-beat-detection;160;131;157;188;133;159;155;132;197;133 08:54:48 INFO - PROCESS | 10726 | |2;audio-dft;163;163;165;173;170;163;162;164;162;163 08:54:48 INFO - PROCESS | 10726 | |3;audio-fft;77;76;76;175;77;78;77;77;156;75 08:54:48 INFO - PROCESS | 10726 | |4;audio-oscillator;86;84;143;84;84;84;137;86;85;132 08:54:48 INFO - PROCESS | 10726 | |5;imaging-gaussian-blur;117;117;117;118;118;119;118;118;118;118 08:54:48 INFO - PROCESS | 10726 | |6;imaging-darkroom;149;150;147;148;148;149;148;149;149;148 08:54:48 INFO - PROCESS | 10726 | |7;imaging-desaturate;95;96;98;96;96;95;96;96;95;96 08:54:48 INFO - PROCESS | 10726 | |8;json-parse-financial;64;64;66;65;65;66;65;65;64;65 08:54:48 INFO - PROCESS | 10726 | |9;json-stringify-tinderbox;65;65;66;66;65;65;65;67;67;66 08:54:48 INFO - PROCESS | 10726 | |10;stanford-crypto-aes;84;84;84;86;85;86;85;92;113;85 08:54:48 INFO - PROCESS | 10726 | |11;stanford-crypto-ccm;141;132;145;144;133;132;135;147;135;137 08:54:48 INFO - PROCESS | 10726 | |12;stanford-crypto-pbkdf2;175;173;166;169;167;168;170;172;167;167 08:54:48 INFO - PROCESS | 10726 | |13;stanford-crypto-sha256-iterative;68;67;69;72;65;67;67;68;71;68 08:54:48 INFO - PROCESS | 10726 | __end_tp_report 08:54:48 INFO - PROCESS | 10726 | __start_cc_report 08:54:48 INFO - PROCESS | 10726 | _x_x_mozilla_cycle_collect,969 08:54:48 INFO - PROCESS | 10726 | __end_cc_report 08:54:48 INFO - PROCESS | 10726 | __startTimestamp1464796488054__endTimestamp 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | ------- Summary: start ------- 08:54:48 INFO - PROCESS | 10726 | Number of tests: 14 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.02 (1.8%) stddev-sans-first:2.12 08:54:48 INFO - PROCESS | 10726 | Values: 114.0 108.0 113.0 114.0 115.0 114.0 113.0 113.0 115.0 112.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:158.00 stddev:23.50 (14.9%) stddev-sans-first:24.84 08:54:48 INFO - PROCESS | 10726 | Values: 160.0 131.0 157.0 188.0 133.0 159.0 155.0 132.0 197.0 133.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:3.71 (2.3%) stddev-sans-first:3.87 08:54:48 INFO - PROCESS | 10726 | Values: 163.0 163.0 165.0 173.0 170.0 163.0 162.0 164.0 162.0 163.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.00 stddev:37.75 (49.0%) stddev-sans-first:39.51 08:54:48 INFO - PROCESS | 10726 | Values: 77.0 76.0 76.0 175.0 77.0 78.0 77.0 77.0 156.0 75.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:84.00 stddev:25.56 (30.4%) stddev-sans-first:26.57 08:54:48 INFO - PROCESS | 10726 | Values: 86.0 84.0 143.0 84.0 84.0 84.0 137.0 86.0 85.0 132.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 08:54:48 INFO - PROCESS | 10726 | Values: 117.0 117.0 117.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 08:54:48 INFO - PROCESS | 10726 | Values: 149.0 150.0 147.0 148.0 148.0 149.0 148.0 149.0 149.0 148.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 08:54:48 INFO - PROCESS | 10726 | Values: 95.0 96.0 98.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:54:48 INFO - PROCESS | 10726 | Values: 64.0 64.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 08:54:48 INFO - PROCESS | 10726 | Values: 65.0 65.0 66.0 66.0 65.0 65.0 65.0 67.0 67.0 66.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.00 stddev:8.96 (10.5%) stddev-sans-first:9.36 08:54:48 INFO - PROCESS | 10726 | Values: 84.0 84.0 84.0 86.0 85.0 86.0 85.0 92.0 113.0 85.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:139.00 stddev:5.69 (4.1%) stddev-sans-first:5.93 08:54:48 INFO - PROCESS | 10726 | Values: 141.0 132.0 145.0 144.0 133.0 132.0 135.0 147.0 135.0 137.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:3.03 (1.8%) stddev-sans-first:2.44 08:54:48 INFO - PROCESS | 10726 | Values: 175.0 173.0 166.0 169.0 167.0 168.0 170.0 172.0 167.0 167.0 08:54:48 INFO - PROCESS | 10726 | 08:54:48 INFO - PROCESS | 10726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.04 (3.0%) stddev-sans-first:2.17 08:54:48 INFO - PROCESS | 10726 | Values: 68.0 67.0 69.0 72.0 65.0 67.0 67.0 68.0 71.0 68.0 08:54:48 INFO - PROCESS | 10726 | -------- Summary: end -------- 08:54:48 INFO - PROCESS | 10726 | 08:54:49 INFO - TEST-INFO | 10726: exit 0 08:54:49 INFO - TEST-OK | kraken | took 64107ms 08:54:49 INFO - SUITE-END | took 1179s 08:54:49 INFO - Completed test suite (00:19:39) 08:54:49 INFO - javascript benchmark 08:54:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6202.905962106871, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.085769980507, 2675.6387887635165, 2684.43626838364, 2687.7177896320886, 2691.3002619318972, 4612.654050946176, 4640.930386044208, 4646.954435252071, 4718.9854181351, 4743.833965811197, 4522.321651752239, 4661.067786442716, 4669.322948172513, 4685.8594242172785, 4735.692180008297, 4279.037216626258, 4342.565743425648, 4380.802863871133, 4408.382826404306, 4409.29451287794, 634.7179565057043, 4201.138766552849, 4245.150969806035, 4249.043965107857, 4272.081502476967, 4301.591348821857, 4302.225599392108, 4306.892327691801, 4314.309710446345, 4321.848735294249, 4338.089001309729, 4361.694681372305, 4369.847055353079, 4375.7593332366705, 4421.801018954155, 4194.2869712149, 4325.221460137174, 4328.826846926119, 4331.090471001094, 4383.75889326087, 4503.347014682852, 4570.680052396334, 4573.839915602971, 4617.515160908123, 4625.468071171825, 4951.851444456672, 5017.147084995559, 5033.219850923113, 5036.244563315496, 5044.54599086084, 4941.901161976776, 5021.17150670139, 5051.848444546669, 5104.770285337168, 5118.488151184889, 4744.454387745419, 4748.715077095385, 4754.881127971828, 4758.524147585248, 4785.688930219525, 5155.0, 5176.8964620707375, 5183.3261675981885, 5189.351331083614, 5225.790968361299, 4864.732439715779, 4873.342098816614, 4922.360093187935, 4927.1131196384995, 5011.198208286657, 4977.303177555145, 5030.647854650212, 5050.090983622983, 5058.772355244023, 5093.032323858455, 4929.605631549467, 4980.576650984634, 4992.276119962585, 5004.324416203839, 5047.772850221749, 4878.487758785347, 4923.729194894244, 4947.851564453073, 4975.228839529878, 4977.377827771528, 4331.501877284152, 4354.804033818486, 4359.17175736609, 4370.0, 4406.581374769392, 3718.2935242303874, 3788.299164654548, 3790.6209379061875, 3794.165283637595, 3848.9807550962064, 4247.830086796555, 4332.761698106634, 4354.172707185625, 4366.345048242725, 4391.582799634093, 4965.0, 4968.701877887338, 4977.850664480072, 4987.725675087905, 5002.924956125661, 4368.453943257093, 4377.9124417511475, 4395.428594282723, 4402.3176407656865, 4414.690971631955, 4478.820847166076, 4488.820447182076, 4493.191225579361, 4501.617362524222, 4579.290210017386, 4689.343491911135, 4731.597814185764, 4741.810327586858, 4753.548412900769, 4759.428868535798, 5045.84862454127, 5090.796368145233, 5105.106606343801, 5107.463716309882, 5133.153029750049, 4608.723476591415, 4719.764011799465, 4753.619710423227, 4753.738544380092, 4802.567768900815, 4926.778294976663, 4942.159832828356, 4950.554450099508, 4964.982178653439, 5008.899822003613, 4982.676126051795, 4996.15065438869, 5033.2701758245585, 5036.949630503648, 5084.906745049684, 4808.975955120202, 4854.78153483087, 4875.902481950412, 4887.0714564232685, 4928.630352723631, 4791.520847915181, 4843.1524483216, 4849.927251091307, 4920.778564964514, 4923.990581930624, 4826.613870890391, 4829.082474329866, 4837.346958160603, 4846.830360937492, 4875.561199492063, 4931.753412329441, 4937.728424936519, 4938.555530002317, 4952.0, 4994.150994331045, 4804.351412559399, 4804.903901922012, 4816.301636262652, 4819.180739274261, 4821.373221481185], "value": 4591.3532417028255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.756307451594, 587.1075964533909, 590.0500194686557, 603.7977277611999, 624.5565648389643, 33365.66634333656, 37829.810850945774, 37853.621463785355, 37916.241675166515, 37943.4308485373, 38800.80599596998, 39059.80470097653, 39240.80379598105, 39269.8036509817, 39299.607003930025, 7554.282343177403, 7623.23767623236, 7631.961840190819, 7646.808829779245, 7666.156722760492, 7564.848703025937, 7658.234176582353, 7708.768736937901, 7711.3059824615775, 7721.691132354727, 7688.769336919901, 7727.574983375912, 7733.342665873408, 7744.303012728853, 7749.496282741604, 7599.354054905312, 7638.5798781067015, 7653.081630204383, 7702.07575090987, 7705.768826935201, 7630.122535908386, 7677.577733224671, 7696.345810606105, 7697.961510192469, 7709.267619576188, 36775.4483682745, 37184.0, 37252.25495490102, 37289.25421491555, 37378.626213737785, 2974.3753811699353, 3132.1386618679817, 3441.7246620270316, 3697.2051009032916, 3811.0, 29340.413191736046, 29344.0, 30046.098617041524, 30095.398092038038, 30749.38501229963, 3275.9516954574547, 3327.617324007746, 3332.283559034795, 3341.214814518586, 3373.241020770307, 173605.0, 174324.0, 174405.0, 174440.0, 240615.99999999825, 33213.50179747306, 52487.475125249024, 52727.20909186288, 52973.47026529763, 53009.734951324994, 34370.312593747985, 34388.48417273743, 34417.65582344145, 34522.30955380928, 34646.65353346484, 13403.597892063253, 13643.727125457435, 13674.521391751241, 13721.0, 13724.382402791898, 11238.157138214667, 11241.831372529256, 11275.887241127484, 11314.0, 11316.755156932732, 7907.525548466995, 7923.0, 7938.364930805522, 7953.403494737802, 7961.164077771867, 3145.0, 3183.2201110727556, 3192.281736609291, 3212.37358715053, 3217.613886333655, 859.656137544987, 860.2472836268265, 974.780674348266, 988.4909271725068, 1013.1540163963173, 27633.723662763517, 28663.0, 28666.856665716954, 28866.567001494994, 29091.85454072716, 970.5050424283667, 1027.1833892055834, 1036.43514284715, 1037.9273450858368, 1099.1591432554103, 14571.41714331436, 14579.41682332716, 14586.4894728684, 15160.0, 15209.467668631545, 371943.0, 372233.0, 372674.0, 376719.0, 377009.0, 49110.508894911305, 49990.25014624783, 50036.0, 50134.74932625386, 50177.24734128991, 1183.8638556566104, 1191.386435985468, 1192.6362459449776, 1193.8925496705165, 1213.1992884696058, 26475.735242648097, 26987.59518607183, 27564.448711025267, 27697.169084927486, 29082.41835163327, 47907.0, 48591.0, 48715.0, 48736.0, 48766.26850597315, 349182.0, 349508.0, 351906.0, 352413.0, 352903.0, 38487.807560962014, 38744.03139921412, 39355.6064439352, 39508.40737388999, 39819.0, 43021.35467968046, 43551.78224108859, 43600.12799743924, 43803.12393752171, 44268.0, 36590.26819463649, 37048.81475592605, 37056.25887482181, 37236.255274894895, 37753.62246377501, 37221.627783721815, 37334.43998339973, 37338.0, 37484.81257593694, 38065.42901856419, 31223.843880780452, 35679.0, 36280.0, 36603.45094823633, 36856.63143368532, 32034.51948220732, 33330.666693333726, 33371.332573347914, 33775.49336759902, 33841.3231735359, 25573.0, 25970.87014564915, 26060.34849128787, 26166.86916565405, 26217.737822622294], "value": 16730.212975209608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.5746176972943, 365.97621154624954, 368.462045413696, 374.5486240816835, 375.4499658001028, 15311.770323445156, 16201.351945922164, 16902.83097169028, 17019.57451063721, 17020.404285849996, 16018.919905400457, 16361.0, 16980.0, 17092.974421534716, 17102.572435689115, 4855.490173531782, 4973.5772459341, 5018.272350509174, 5033.748312584375, 5036.672616279949, 3686.981565092184, 4875.414950205963, 5550.47270509303, 5778.3643799182055, 5814.447627475383, 5861.3552509223955, 5868.03177475716, 5890.234269544953, 5902.203202567642, 5916.822495325126, 5667.263255776743, 5800.738966746507, 5851.502622277111, 5887.264091988502, 5891.086881533369, 4918.262260660929, 5069.822556210515, 5095.133827249377, 5097.643164978453, 5113.156329205676, 20004.199832006703, 20035.699464508045, 20196.49508762278, 20222.09000594962, 20520.281790137422, 1852.1757817771097, 1884.5759704066475, 1890.8392786613153, 1974.3188599933, 2059.660156074246, 12854.935725321313, 13325.733485330336, 13450.12574182675, 13573.796393054112, 13610.115342502804, 1766.567191038191, 1772.831580999803, 1778.1287169287086, 1818.8181181881705, 1856.8421684156729, 63778.3622163777, 67316.0, 67344.66327668379, 67596.6620166901, 68508.6574567124, 9027.187553120251, 9089.95455022734, 9493.620255189715, 9535.666251681158, 9631.036896310314, 12740.617781466572, 12781.61655150347, 12848.164869283466, 12857.357132143356, 12861.228326300452, 6811.148606424197, 6875.209350924708, 6935.445164386837, 7018.122734658168, 7039.084918960502, 6531.477481801445, 6584.868302634016, 6745.662716864235, 6749.122614060141, 6759.188897332253, 5654.293213348332, 5780.011791863601, 5842.386549412336, 5860.882782344414, 6000.519958403317, 1590.721623715845, 1665.7418100194488, 1678.6055277009893, 1760.4542591796328, 1804.3414153833755, 851.9914800852036, 874.7856775090144, 886.5965985476722, 917.3257655623112, 1020.2756043209405, 15947.0, 16474.58813529671, 16698.58253543671, 16774.161291935354, 16884.155792210342, 865.3769286113987, 867.2844902955087, 886.2378354615026, 904.0778406025817, 938.7230766923637, 9424.434533927986, 9625.085616866387, 9719.708408747749, 9815.705528834147, 9944.204463642891, 377787.0, 381279.0, 383009.0, 422361.0, 428525.0, 48808.26787598189, 50918.745406272734, 75968.0, 77649.61175194087, 85662.14337856666, 928.0858354520792, 928.2434815625379, 967.4002118686459, 970.427447805798, 974.0503009565758, 15103.0, 15141.848581514043, 15169.165695886832, 15266.465673701367, 15723.528294151194, 33803.323933521686, 34783.13042173966, 34903.650963491054, 35084.824575876955, 35766.463503048, 44638.77680611576, 46181.538184617726, 50408.0, 50932.49067509278, 50945.0, 4652.162610730101, 5566.387697353207, 6950.826229344307, 7204.855902881808, 7310.96344518274, 9485.810283794148, 10197.0, 10471.418651933396, 10675.412852293199, 10732.409717465614, 6690.0, 8930.330225233003, 9149.130832570896, 9318.347715659838, 9548.283878709264, 8872.0, 8880.0, 9211.170994610517, 9281.67514137002, 9372.484513351832, 9144.050521603496, 9150.267978561833, 9446.527673616154, 9496.382735122195, 9771.364861283993, 7060.752873649398, 7132.643367831484, 7214.6392680364725, 7226.060612120391, 7299.927000729925, 8727.91272087271, 8980.236679882284, 9299.116583924517, 9557.856632150384, 9846.704598862045], "value": 8071.314695968275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.5282403982646, 1425.365712258045, 1505.4881340344282, 1702.7956645202578, 1704.233095107202, 6652.866942661144, 7362.300581444761, 7377.778666639996, 7854.0, 7952.920470795298, 7564.319211270985, 7626.351760100384, 7646.808829779258, 7656.846863062749, 7788.104367997682, 2172.6849606806963, 2217.2572188316935, 2220.200727738013, 2221.311393468022, 2226.866388016716, 2168.739751229855, 2190.266260802625, 2209.801117899389, 2218.8557743746687, 2219.289827255279, 2169.620316444616, 2177.346795961213, 2187.704659870913, 2200.0759680933966, 2230.230570453199, 2102.2221777942104, 2104.389726979182, 2105.463106907744, 2153.5154590217235, 2186.256672731279, 2109.135254545629, 2122.193566444741, 2126.6384714598403, 2138.6898899659463, 2149.387424583986, 7699.615019249071, 7709.575973321465, 7727.0, 7730.845383092363, 7779.72770953014, 4544.772761361952, 4654.371659825948, 4656.022235330584, 4656.41794775653, 4672.462666793328, 2735.275152084699, 2842.204182828811, 2860.2134413036374, 2866.971330286691, 2869.7704183665255, 908.1145882764318, 959.7696552827341, 965.4062751407904, 976.8778902637171, 979.2019504104132, 10295.279330446872, 10413.635522756744, 10449.79100417995, 10603.257771955967, 10621.522031508523, 4267.1892340455215, 4284.271673815459, 4363.716358436692, 4372.453443319585, 4376.102898905717, 8942.46345219289, 8965.058668839809, 8983.640654373883, 9087.318451116193, 9089.454632722058, 4592.7933243004145, 4615.746133962597, 4633.4671512775785, 4648.814047438064, 4662.370579971661, 3723.1809002019513, 3868.845246190121, 4020.6381425671243, 4180.101278225196, 4248.044190057212, 3631.6368363163474, 3716.4053751399647, 3748.3065632857465, 3780.8487660493274, 3803.1252811852873, 1156.5605070073486, 1209.504103317653, 1217.6773155113901, 1227.699213692651, 1238.6903274181454, 827.4332082523491, 839.2824135364298, 850.9702160424356, 868.68727258187, 874.9518776467355, 5075.644704870698, 5199.246109314128, 5199.272101905736, 5210.843674689765, 5329.600279978939, 414.678624066351, 432.5695932547136, 434.20323705999846, 439.93181056936226, 440.06047089464226, 3553.875614353537, 3624.6919011883756, 3658.34149853029, 3680.6687398134295, 3709.4435834625024, 9199.724008279762, 9329.207017403596, 9341.766455838522, 9425.340226184102, 9434.48110353937, 9238.815223695488, 9342.626294948126, 9365.391249568756, 9414.95292523533, 9539.379940303857, 7168.856622867514, 7180.533265337736, 7187.9640601796655, 7193.568385896968, 7246.96376518114, 5063.594912406925, 5112.590992720648, 5126.4617215191865, 5360.035193665021, 5370.275012873212, 8724.825503489768, 8743.0, 8758.693445729368, 8795.296376290009, 8901.465912045298, 8249.670013199404, 8495.957520212607, 8517.190866867637, 8814.955925220589, 8912.73261802147, 5803.47768700819, 6076.513878889767, 6144.446999770043, 6607.372299631527, 6747.257801641717, 6980.406665433495, 6982.965085174745, 6998.6850591724515, 7007.649617519001, 7028.472864535078, 6204.658743769136, 6393.744250229939, 6401.199850018747, 6429.4534964526665, 6463.7737679181, 6328.303886572566, 6456.160699109086, 6551.344865513411, 6604.240512341143, 6703.363180497845, 6125.877482450237, 6126.08108783686, 6145.4161854623735, 6183.752649893954, 6213.37866213375, 4553.886152846206, 4571.3371561122785, 4593.494715581351, 4600.516945720651, 4604.1252162089095, 4510.210713125124, 4554.0664163847, 4559.156556037144, 4563.475200352002, 4584.679072464895], "value": 4023.4987739856597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4047256668081, 302.84403532180926, 308.87490566320633, 312.20232306456995, 312.431374897686, 4953.801847926087, 4996.851983250556, 5009.524095210953, 5049.495050494948, 5079.695218286901, 4923.926141107877, 4957.677750946186, 4962.528559786823, 4972.552470277675, 4987.501249875011, 3690.1697118148472, 3784.3944968804994, 3938.8424463021443, 3941.8423263069444, 3948.1708841143395, 3899.317619416605, 3921.450996860442, 3935.822887970048, 3958.1885713428824, 3962.6433620974108, 3940.743851649648, 3951.2097580483874, 3960.3069462844032, 3970.1067259866445, 3977.82099805508, 3838.7120965927666, 3841.1741475582603, 3901.4928059352387, 3960.9801950990204, 3967.2660557796758, 3443.5867695876404, 3467.133216695826, 3469.9479507807405, 3472.871316822043, 3473.930521389583, 4746.240601503743, 4748.928766068511, 4760.666753327268, 4779.402574678165, 4781.713097214143, 4396.78016099197, 4477.529859364785, 4503.909921801578, 4516.458025037016, 4526.864194074183, 5221.269022336875, 5221.321228240305, 5236.92144617831, 5239.502247286502, 5257.7108259045735, 3797.620237976208, 3806.695464362844, 3806.7144964127524, 3809.5238095238096, 3824.694024478035, 5261.421573527965, 5478.808241711561, 5489.176623506466, 5512.862178445531, 5548.833534993957, 3894.5131858517684, 3900.91301153887, 3902.8829135125993, 3913.726039177287, 3923.0388554803685, 3905.4337121117846, 3924.4898163238595, 3930.6855451563806, 3944.6647035002347, 3960.20795840833, 4385.736855788663, 4425.867223983286, 4452.220861349251, 4464.397306363664, 4468.419105516262, 4944.330061766677, 5194.974025129925, 5206.609504287194, 5221.295125158055, 5298.390685071189, 1326.4495234477777, 1340.1021315718492, 1341.872522110398, 1345.8519562848078, 1350.9729805403838, 824.9752507424787, 835.8202986357962, 853.8643604006656, 871.0810095349341, 871.7166920750782, 4538.591526762607, 4596.7931443085145, 4597.586217240464, 4639.164950308909, 4644.58198762113, 5384.542313903284, 5385.353757549041, 5401.513863752281, 5409.891802163935, 5411.83764487066, 4512.165249428866, 4628.83799067031, 4634.490206077328, 4651.720896746206, 4659.603933665677, 2828.5050116229577, 2879.2226098953583, 2891.493988551995, 2894.9276268093467, 2923.137674386061, 5070.112730272188, 5081.5426611605135, 5088.77100530477, 5096.745162741922, 5114.769835357418, 5424.83725488236, 5539.556835453154, 5557.638753481011, 5602.551795856321, 5634.267545219095, 5082.364704411949, 5084.5932325414615, 5099.923501147486, 5116.9744151279, 5129.820456284012, 5393.298871146726, 5412.621116521806, 5425.864353391039, 5457.181422786613, 5469.75386107634, 5021.221710634857, 5301.443348448357, 5327.629205003736, 5341.919871201857, 5377.924415116914, 5114.514121158632, 5121.180611102206, 5146.6911985281, 5154.896902061862, 5162.199859021857, 3784.5836957934052, 3806.219724956322, 3818.8472461101246, 3823.5602905666206, 3828.7173796778393, 5108.0, 5355.2234925934745, 5374.946250537445, 5381.919271210857, 5466.04833389965, 5159.226116082617, 5162.793488260578, 5174.560162386088, 5178.119719647593, 5204.479552044765, 5208.4270730220405, 5215.81744638951, 5228.607854410859, 5235.0, 5239.842804715865, 4977.527134922177, 5159.684280508446, 5164.354455693038, 5170.922436163536, 5175.654329874184, 5026.623003274842, 5140.0, 5218.834183813827, 5246.895062098661, 5268.0, 5135.972805439002, 5182.792688292426, 5191.195364718475, 5209.395302348826, 5225.268462415189], "value": 3954.257185905719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.5902386377264, 644.2719726708818, 644.6325594411187, 653.9607623542588, 656.1961597043619, 10412.791744165123, 10719.35683858969, 10865.945670271658, 10878.347299162057, 10948.835767463484, 11296.209265351428, 11356.205065645387, 11380.658580242585, 11404.771904561903, 11408.20142590017, 628.4406877878691, 769.2845653542204, 783.5024759277857, 789.5341748368461, 799.8640231160688, 782.62042909189, 785.0540099180503, 785.8821176823465, 787.3583029830698, 788.5268838696765, 826.6734639817269, 828.0394742099166, 829.0383155539575, 831.71721614651, 831.7296878514477, 822.9465084769471, 823.6664151018817, 828.1470085811624, 828.4076885027174, 828.6933834481281, 606.1574411567924, 606.3421188011014, 606.754264522869, 606.9817905462843, 607.168179593959, 11451.94274028633, 11497.712557186054, 11499.540018399337, 11504.079673626173, 11554.480048397842, 10987.890121098766, 11107.222494425394, 11192.552297908074, 11238.943805280922, 11311.936573773137, 9431.717048488556, 9478.810423791554, 9570.282228832866, 9595.328327017112, 9740.805183896353, 2993.4013197360614, 3054.8167109973474, 3088.737457316131, 3097.9690203097907, 3141.984290078535, 42949.57050429487, 43587.34618980718, 43817.561824381664, 43869.341959870624, 44943.32585011228, 9058.0, 9198.356115071882, 9207.309451791143, 9275.95362023199, 9291.814163716688, 17180.140992950302, 17187.828121718623, 17201.655966880593, 17208.82791172097, 17221.56946076358, 6357.078223657544, 6413.16628838248, 6474.611523308617, 6483.124778154889, 6490.286068532458, 3453.8791142309897, 3492.8253587320532, 3518.0, 3588.7129029677562, 3589.10272431892, 2646.7617914387797, 2772.7365900239447, 2775.139706690932, 2822.971770282271, 2840.233137052984, 552.0918089742352, 552.8942115768463, 552.9861753456196, 563.2143160291371, 569.9458551437607, 520.9088409528317, 606.6329870428416, 618.3476432363809, 622.4273668225244, 627.8367624417593, 7707.190744971809, 7780.416468764865, 7914.592157737035, 8102.351811855037, 8111.9594402027615, 557.8995780759421, 590.8375196820823, 613.7667686279185, 625.4183609243447, 638.7923924724483, 3632.8183590820354, 3718.442233664972, 3721.5162028936065, 3796.6393192646656, 3879.1853710721066, 51546.74226628843, 52907.735461322445, 53043.734781325846, 53211.73394133004, 53489.0, 46728.766356168, 47851.52148478471, 48478.5152148474, 48636.27045594319, 49099.509004909494, 29140.854295728386, 44312.335314969656, 46378.76810615993, 46455.0, 47694.52305476901, 8093.109757926505, 8175.1416101308505, 8225.506469611842, 8240.340772738047, 8364.916350836414, 30788.0, 30899.536506951965, 30977.0, 31012.53481197829, 31496.37007259888, 37262.44106338353, 40591.18817623572, 40721.0, 41004.384934226604, 41170.38244426396, 10004.521761598862, 10090.09189172978, 10191.847122293024, 10290.845637315597, 10354.637587684696, 10574.524146413276, 10846.132309415385, 11245.38150401703, 11398.0, 11907.642770716893, 10732.248742587944, 10774.191935605018, 10789.082927950898, 11499.54001839917, 11623.59317423886, 10851.511681974487, 11088.66733997949, 11185.0, 11198.38408887519, 11219.7756044877, 9866.358686685342, 10128.493575321352, 10337.638182663572, 10454.477276136315, 11193.328400296008, 8844.823103538021, 8920.955395223242, 8959.910400895908, 8965.327600430124, 9158.95420522893, 8770.210681038738, 8903.243224326005, 9074.546272686472, 9406.529673516434, 9519.524023798644], "value": 5773.8925957515685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 115.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 131.0, 157.0, 188.0, 133.0, 159.0, 155.0, 132.0, 197.0, 133.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 173.0, 170.0, 163.0, 162.0, 164.0, 162.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 175.0, 77.0, 78.0, 77.0, 77.0, 156.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 143.0, 84.0, 84.0, 84.0, 137.0, 86.0, 85.0, 132.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 147.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 67.0, 67.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 86.0, 85.0, 92.0, 113.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 145.0, 144.0, 133.0, 132.0, 135.0, 147.0, 135.0, 137.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 166.0, 169.0, 167.0, 168.0, 170.0, 172.0, 167.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 72.0, 65.0, 67.0, 67.0, 68.0, 71.0, 68.0], "value": 68.2, "unit": "score"}]}]} 08:54:49 INFO - Return code: 0 08:54:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:54:49 ERROR - # TBPL SUCCESS # 08:54:49 INFO - Running post-action listener: _resource_record_post_action 08:54:49 INFO - ##### 08:54:49 INFO - ##### Finished run-tests step (success) 08:54:49 INFO - ##### 08:54:49 INFO - Running post-run listener: _resource_record_post_run 08:54:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544350208; Read time: 12; Write time: 402080 08:54:49 INFO - TinderboxPrint: CPU usage
13.4% 08:54:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:54:49 INFO - TinderboxPrint: I/O write bytes / time
544,350,208 / 402,080 08:54:49 INFO - TinderboxPrint: CPU idle
8,261.6 (86.6%) 08:54:49 INFO - TinderboxPrint: CPU user
1,230.0 (12.9%) 08:54:49 INFO - TinderboxPrint: Swap in / out
0 / 0 08:54:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237326336; Read time: 0; Write time: 221080 08:54:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286007296; Read time: 12; Write time: 162880 08:54:49 INFO - Running post-run listener: _upload_blobber_files 08:54:49 INFO - Blob upload gear active. 08:54:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:54:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:54:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:54 INFO - (blobuploader) - INFO - Done attempting. 08:54:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:57 INFO - (blobuploader) - INFO - Done attempting. 08:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:17 INFO - (blobuploader) - INFO - Done attempting. 08:55:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:18 INFO - Return code: 0 08:55:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7930960cd9d05dd4cd09502dad01e09cbc54c4ab077e9fce8457de593a2fd7a3f5d35a2b79ca40a8c468fe9139bfabcc87339dbc0fa9716c9e3257c67b312c45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0347bed39f7c55bf499cb77c8841e66dd447f5fd8c534d236836cdc5bc2d8bd3470e99f6077412b8cc7ac2c7561319264c69108467ab3b7603dc9a6398f23ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e31bd6efd4fd23568109415d5843a772f3d1bfd71e8019443d07debac398e2b651ee07b6101ea5721b7c973e9be94b7ccdea122f947ae054513e6386f373846"} 08:55:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:18 INFO - Contents: 08:55:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7930960cd9d05dd4cd09502dad01e09cbc54c4ab077e9fce8457de593a2fd7a3f5d35a2b79ca40a8c468fe9139bfabcc87339dbc0fa9716c9e3257c67b312c45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0347bed39f7c55bf499cb77c8841e66dd447f5fd8c534d236836cdc5bc2d8bd3470e99f6077412b8cc7ac2c7561319264c69108467ab3b7603dc9a6398f23ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e31bd6efd4fd23568109415d5843a772f3d1bfd71e8019443d07debac398e2b651ee07b6101ea5721b7c973e9be94b7ccdea122f947ae054513e6386f373846"} 08:55:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:18 INFO - Copying logs to upload dir... 08:55:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.277434 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-01 08:55:17.933227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:55:17.936878) ========= 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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7930960cd9d05dd4cd09502dad01e09cbc54c4ab077e9fce8457de593a2fd7a3f5d35a2b79ca40a8c468fe9139bfabcc87339dbc0fa9716c9e3257c67b312c45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0347bed39f7c55bf499cb77c8841e66dd447f5fd8c534d236836cdc5bc2d8bd3470e99f6077412b8cc7ac2c7561319264c69108467ab3b7603dc9a6398f23ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e31bd6efd4fd23568109415d5843a772f3d1bfd71e8019443d07debac398e2b651ee07b6101ea5721b7c973e9be94b7ccdea122f947ae054513e6386f373846"} build_url:https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7930960cd9d05dd4cd09502dad01e09cbc54c4ab077e9fce8457de593a2fd7a3f5d35a2b79ca40a8c468fe9139bfabcc87339dbc0fa9716c9e3257c67b312c45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0347bed39f7c55bf499cb77c8841e66dd447f5fd8c534d236836cdc5bc2d8bd3470e99f6077412b8cc7ac2c7561319264c69108467ab3b7603dc9a6398f23ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e31bd6efd4fd23568109415d5843a772f3d1bfd71e8019443d07debac398e2b651ee07b6101ea5721b7c973e9be94b7ccdea122f947ae054513e6386f373846"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:55:17.961839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:55:17.962162) ========= 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=00204705a9daa57ed339a427000001b9-1464795256.169214-200108303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:55:18.047253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:55:18.047578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:55:18.047869) ========= ========= Total master_lag: 0.17 =========