builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1464804487.72 results: success (0) buildid: 20160601083038 builduid: 7f6c4537de3a48299af92e5c7b60b6d9 revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.724733) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.725214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.725565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.745586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.745938) ========= 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-1464803122.897397-1642509559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 11:08:07-- 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 11:08:08 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123029 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.899308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.899767) ========= 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-1464803122.897397-1642509559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022831 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:07.953018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 11:08:07.953346) ========= 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-1464803122.897397-1642509559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 11:08:08,174 truncating revision to first 12 chars 2016-06-01 11:08:08,175 Setting DEBUG logging. 2016-06-01 11:08:08,175 attempt 1/10 2016-06-01 11:08:08,175 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 11:08:08,899 unpacking tar archive at: fx-team-5d2cb7fff024/testing/mozharness/ program finished with exit code 0 elapsedTime=1.483312 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 11:08:09.451434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:09.451829) ========= script_repo_revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:09.452275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:09.452572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 11:08:09.463048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-01 11:08:09.463450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:09 INFO - MultiFileLogger online at 20160601 11:08:09 in /builds/slave/test 11:08:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:08:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:09 INFO - {'append_to_log': False, 11:08:09 INFO - 'base_work_dir': '/builds/slave/test', 11:08:09 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:09 INFO - 'branch': 'Fx-Team', 11:08:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:09 INFO - 'config_files': ('talos/linux_config.py',), 11:08:09 INFO - 'default_actions': ('clobber', 11:08:09 INFO - 'read-buildbot-config', 11:08:09 INFO - 'download-and-extract', 11:08:09 INFO - 'populate-webroot', 11:08:09 INFO - 'create-virtualenv', 11:08:09 INFO - 'install', 11:08:09 INFO - 'run-tests'), 11:08:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:09 INFO - 'download_minidump_stackwalk': True, 11:08:09 INFO - 'download_symbols': 'ondemand', 11:08:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:09 INFO - 'installer_path': 'installer.exe', 11:08:09 INFO - 'log_level': 'info', 11:08:09 INFO - 'log_name': 'talos', 11:08:09 INFO - 'log_to_console': True, 11:08:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:09 INFO - 'opt_config_files': (), 11:08:09 INFO - 'pip_index': False, 11:08:09 INFO - 'sps_profile': False, 11:08:09 INFO - 'sps_profile_interval': 0, 11:08:09 INFO - 'suite': 'dromaeojs-e10s', 11:08:09 INFO - 'system_bits': '32', 11:08:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:09 INFO - 'title': 'talos-linux64-ix-016', 11:08:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:09 INFO - 'use_talos_json': True, 11:08:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:09 INFO - 'work_dir': 'build'} 11:08:09 INFO - ##### 11:08:09 INFO - ##### Running clobber step. 11:08:09 INFO - ##### 11:08:09 INFO - Running pre-action listener: _resource_record_pre_action 11:08:09 INFO - Running main action method: clobber 11:08:09 INFO - rmtree: /builds/slave/test/build 11:08:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:10 INFO - Running post-action listener: _resource_record_post_action 11:08:10 INFO - ##### 11:08:10 INFO - ##### Finished clobber step (success) 11:08:10 INFO - ##### 11:08:10 INFO - ##### 11:08:10 INFO - ##### Running read-buildbot-config step. 11:08:10 INFO - ##### 11:08:10 INFO - Running pre-action listener: _resource_record_pre_action 11:08:10 INFO - Running main action method: read_buildbot_config 11:08:10 INFO - Using buildbot properties: 11:08:10 INFO - { 11:08:10 INFO - "project": "", 11:08:10 INFO - "product": "firefox", 11:08:10 INFO - "script_repo_revision": "production", 11:08:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:08:10 INFO - "repository": "", 11:08:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:08:10 INFO - "buildid": "20160601083038", 11:08:10 INFO - "pgo_build": "True", 11:08:10 INFO - "basedir": "/builds/slave/test", 11:08:10 INFO - "buildnumber": 518, 11:08:10 INFO - "slavename": "talos-linux64-ix-016", 11:08:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:08:10 INFO - "platform": "ubuntu64_hw", 11:08:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:10 INFO - "branch": "fx-team", 11:08:10 INFO - "repo_path": "integration/fx-team", 11:08:10 INFO - "revision": "5d2cb7fff024a1d3ed59ad2432882d158ce5ee91", 11:08:10 INFO - "stage_platform": "linux64-pgo", 11:08:10 INFO - "builduid": "7f6c4537de3a48299af92e5c7b60b6d9", 11:08:10 INFO - "slavebuilddir": "test" 11:08:10 INFO - } 11:08:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:08:10 INFO - Running post-action listener: _resource_record_post_action 11:08:10 INFO - ##### 11:08:10 INFO - ##### Finished read-buildbot-config step (success) 11:08:10 INFO - ##### 11:08:10 INFO - ##### 11:08:10 INFO - ##### Running download-and-extract step. 11:08:10 INFO - ##### 11:08:10 INFO - Running pre-action listener: _resource_record_pre_action 11:08:10 INFO - Running main action method: download_and_extract 11:08:10 INFO - mkdir: /builds/slave/test/build/tests 11:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:10 INFO - https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:15 INFO - Downloaded 1361 bytes. 11:08:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:08:15 INFO - Using the following test package requirements: 11:08:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'jsshell-linux-x86_64.zip'], 11:08:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:15 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')]} 11:08:15 INFO - https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:18 INFO - Downloaded 24422473 bytes. 11:08:18 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'] 11:08:18 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 11:08:19 INFO - Return code: 0 11:08:19 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 11:08: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')]} 11:08:19 INFO - https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:21 INFO - Downloaded 24422473 bytes. 11:08:21 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'] 11:08:21 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 11:08:22 INFO - Return code: 0 11:08:22 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')]} 11:08:22 INFO - https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:24 INFO - Downloaded 10834055 bytes. 11:08:24 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'] 11:08:24 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 11:08:24 INFO - Return code: 0 11:08: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')]} 11:08:24 INFO - https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:08:25 INFO - Downloaded 59029949 bytes. 11:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:08:25 INFO - mkdir: /builds/slave/test/properties 11:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:25 INFO - Contents: 11:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:08:26 INFO - Running post-action listener: _resource_record_post_action 11:08:26 INFO - Running post-action listener: set_extra_try_arguments 11:08:26 INFO - ##### 11:08:26 INFO - ##### Finished download-and-extract step (success) 11:08:26 INFO - ##### 11:08:26 INFO - ##### 11:08:26 INFO - ##### Running populate-webroot step. 11:08:26 INFO - ##### 11:08:26 INFO - Running pre-action listener: _resource_record_pre_action 11:08:26 INFO - Running main action method: populate_webroot 11:08:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:26 INFO - '--tppagecycles', 11:08:26 INFO - '7'], 11:08:26 INFO - 'tests': ['tsvgm']}}, 11:08:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['damp', 'tps']}, 11:08:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'tests': ['damp', 'tps']}, 11:08:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['dromaeo_dom']}, 11:08:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['a11yr', 11:08:26 INFO - 'ts_paint', 11:08:26 INFO - 'tpaint', 11:08:26 INFO - 'sessionrestore', 11:08:26 INFO - 'sessionrestore_no_auto_restore', 11:08:26 INFO - 'tabpaint']}, 11:08:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['tsvgx', 11:08:26 INFO - 'tsvgr_opacity', 11:08:26 INFO - 'tart', 11:08:26 INFO - 'tscrollx', 11:08:26 INFO - 'cart']}, 11:08:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:26 INFO - 'tsvgr_opacity', 11:08:26 INFO - 'tart', 11:08:26 INFO - 'tscrollx', 11:08:26 INFO - 'cart']}, 11:08:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'talos_options': ['--disable-e10s'], 11:08:26 INFO - 'tests': ['tp5o']}, 11:08:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'tests': ['tp5o']}, 11:08:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'talos_options': ['--disable-e10s', 11:08:26 INFO - '--xperf_path', 11:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:26 INFO - 'tests': ['tp5n']}, 11:08:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:26 INFO - 'talos_options': ['--xperf_path', 11:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:26 INFO - 'tests': ['tp5n']}}, 11:08:26 INFO - 'talos.zip': {'path': '', 11:08:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:26 INFO - Running post-action listener: _resource_record_post_action 11:08:26 INFO - ##### 11:08:26 INFO - ##### Finished populate-webroot step (success) 11:08:26 INFO - ##### 11:08:26 INFO - ##### 11:08:26 INFO - ##### Running create-virtualenv step. 11:08:26 INFO - ##### 11:08:26 INFO - Running pre-action listener: _resource_record_pre_action 11:08:26 INFO - Running main action method: create_virtualenv 11:08:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:26 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 11:08:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:26 INFO - Using real prefix '/usr' 11:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:29 INFO - Installing pip.................done. 11:08:29 INFO - Return code: 0 11:08:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:29 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 11:08:29 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 11:08:29 INFO - Using env: {'DISPLAY': ':0', 11:08:29 INFO - 'HOME': '/home/cltbld', 11:08:29 INFO - 'LANG': 'en_US.UTF-8', 11:08:29 INFO - 'LANGUAGE': 'en_US:en', 11:08:29 INFO - 'LOGNAME': 'cltbld', 11:08:29 INFO - 'MAIL': '/var/mail/cltbld', 11:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:29 INFO - 'MOZ_NO_REMOTE': '1', 11:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:29 INFO - 'NO_EM_RESTART': '1', 11:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:29 INFO - 'PWD': '/builds/slave/test', 11:08:29 INFO - 'SHELL': '/bin/bash', 11:08:29 INFO - 'SHLVL': '1', 11:08:29 INFO - 'TERM': 'linux', 11:08:29 INFO - 'TMOUT': '86400', 11:08:29 INFO - 'USER': 'cltbld', 11:08:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:29 INFO - '_': '/tools/buildbot/bin/python'} 11:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:29 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 11:08:29 INFO - Cleaning up... 11:08:29 INFO - Return code: 0 11:08:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:29 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 11:08:29 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 11:08:29 INFO - Using env: {'DISPLAY': ':0', 11:08:29 INFO - 'HOME': '/home/cltbld', 11:08:29 INFO - 'LANG': 'en_US.UTF-8', 11:08:29 INFO - 'LANGUAGE': 'en_US:en', 11:08:29 INFO - 'LOGNAME': 'cltbld', 11:08:29 INFO - 'MAIL': '/var/mail/cltbld', 11:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:29 INFO - 'MOZ_NO_REMOTE': '1', 11:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:29 INFO - 'NO_EM_RESTART': '1', 11:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:29 INFO - 'PWD': '/builds/slave/test', 11:08:29 INFO - 'SHELL': '/bin/bash', 11:08:29 INFO - 'SHLVL': '1', 11:08:29 INFO - 'TERM': 'linux', 11:08:29 INFO - 'TMOUT': '86400', 11:08:29 INFO - 'USER': 'cltbld', 11:08:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:29 INFO - '_': '/tools/buildbot/bin/python'} 11:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:29 INFO - Downloading/unpacking psutil>=3.1.1 11:08:29 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 11:08:29 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 11:08:29 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 11:08:29 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 11:08:29 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 11:08:29 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 11:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:31 INFO - Installing collected packages: psutil 11:08:31 INFO - Running setup.py install for psutil 11:08:31 INFO - building 'psutil._psutil_linux' extension 11:08:31 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 11:08:31 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 11:08:31 INFO - building 'psutil._psutil_posix' extension 11:08:31 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 11:08:31 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 11:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:31 INFO - Successfully installed psutil 11:08:31 INFO - Cleaning up... 11:08:32 INFO - Return code: 0 11:08:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:32 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:32 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 11:08:32 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 11:08:32 INFO - Using env: {'DISPLAY': ':0', 11:08:32 INFO - 'HOME': '/home/cltbld', 11:08:32 INFO - 'LANG': 'en_US.UTF-8', 11:08:32 INFO - 'LANGUAGE': 'en_US:en', 11:08:32 INFO - 'LOGNAME': 'cltbld', 11:08:32 INFO - 'MAIL': '/var/mail/cltbld', 11:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:32 INFO - 'MOZ_NO_REMOTE': '1', 11:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:32 INFO - 'NO_EM_RESTART': '1', 11:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:32 INFO - 'PWD': '/builds/slave/test', 11:08:32 INFO - 'SHELL': '/bin/bash', 11:08:32 INFO - 'SHLVL': '1', 11:08:32 INFO - 'TERM': 'linux', 11:08:32 INFO - 'TMOUT': '86400', 11:08:32 INFO - 'USER': 'cltbld', 11:08:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:32 INFO - '_': '/tools/buildbot/bin/python'} 11:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:08:32 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 11:08:32 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 11:08:32 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 11:08:32 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 11:08:32 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 11:08:32 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 11:08:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:08:34 INFO - Installing collected packages: mozsystemmonitor 11:08:34 INFO - Running setup.py install for mozsystemmonitor 11:08:34 INFO - Successfully installed mozsystemmonitor 11:08:34 INFO - Cleaning up... 11:08:34 INFO - Return code: 0 11:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:34 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:34 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 11:08:34 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 11:08:34 INFO - Using env: {'DISPLAY': ':0', 11:08:34 INFO - 'HOME': '/home/cltbld', 11:08:34 INFO - 'LANG': 'en_US.UTF-8', 11:08:34 INFO - 'LANGUAGE': 'en_US:en', 11:08:34 INFO - 'LOGNAME': 'cltbld', 11:08:34 INFO - 'MAIL': '/var/mail/cltbld', 11:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:34 INFO - 'MOZ_NO_REMOTE': '1', 11:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:34 INFO - 'NO_EM_RESTART': '1', 11:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:34 INFO - 'PWD': '/builds/slave/test', 11:08:34 INFO - 'SHELL': '/bin/bash', 11:08:34 INFO - 'SHLVL': '1', 11:08:34 INFO - 'TERM': 'linux', 11:08:34 INFO - 'TMOUT': '86400', 11:08:34 INFO - 'USER': 'cltbld', 11:08:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:34 INFO - '_': '/tools/buildbot/bin/python'} 11:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:34 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 11:08:34 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 11:08:34 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 11:08:34 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 11:08:34 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 11:08:34 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 11:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:37 INFO - Downloading docopt-0.6.1.tar.gz 11:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:37 INFO - Running setup.py install for blobuploader 11:08:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:37 INFO - Running setup.py install for requests 11:08:37 INFO - Running setup.py install for docopt 11:08:37 INFO - Successfully installed blobuploader requests docopt 11:08:37 INFO - Cleaning up... 11:08:37 INFO - Return code: 0 11:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:37 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:37 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 11:08:37 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 11:08:37 INFO - Using env: {'DISPLAY': ':0', 11:08:37 INFO - 'HOME': '/home/cltbld', 11:08:37 INFO - 'LANG': 'en_US.UTF-8', 11:08:37 INFO - 'LANGUAGE': 'en_US:en', 11:08:37 INFO - 'LOGNAME': 'cltbld', 11:08:37 INFO - 'MAIL': '/var/mail/cltbld', 11:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:37 INFO - 'MOZ_NO_REMOTE': '1', 11:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:37 INFO - 'NO_EM_RESTART': '1', 11:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:37 INFO - 'PWD': '/builds/slave/test', 11:08:37 INFO - 'SHELL': '/bin/bash', 11:08:37 INFO - 'SHLVL': '1', 11:08:37 INFO - 'TERM': 'linux', 11:08:37 INFO - 'TMOUT': '86400', 11:08:37 INFO - 'USER': 'cltbld', 11:08:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:37 INFO - '_': '/tools/buildbot/bin/python'} 11:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:38 INFO - Running setup.py (path:/tmp/pip-f563Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:38 INFO - Running setup.py (path:/tmp/pip-i0ykTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:38 INFO - Running setup.py (path:/tmp/pip-BKm_kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:38 INFO - Running setup.py (path:/tmp/pip-oRXUyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:38 INFO - Running setup.py (path:/tmp/pip-iRHaWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:38 INFO - Running setup.py (path:/tmp/pip-suu7oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:38 INFO - Running setup.py (path:/tmp/pip-ieEF_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:38 INFO - Running setup.py (path:/tmp/pip-lWK19Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:38 INFO - Running setup.py (path:/tmp/pip-kgB3d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:38 INFO - Running setup.py (path:/tmp/pip-Ku0Nff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:38 INFO - Running setup.py (path:/tmp/pip-RfG1k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:38 INFO - Running setup.py (path:/tmp/pip-o5D8kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:38 INFO - Running setup.py (path:/tmp/pip-5lKtQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:38 INFO - Running setup.py (path:/tmp/pip-Zdiyn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:39 INFO - Running setup.py (path:/tmp/pip-PbCt07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:39 INFO - Running setup.py (path:/tmp/pip-UzLlEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:39 INFO - Running setup.py (path:/tmp/pip-GzaJmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:39 INFO - Running setup.py install for manifestparser 11:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:39 INFO - Running setup.py install for mozcrash 11:08:39 INFO - Running setup.py install for mozdebug 11:08:39 INFO - Running setup.py install for mozdevice 11:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:39 INFO - Running setup.py install for mozfile 11:08:39 INFO - Running setup.py install for mozhttpd 11:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:39 INFO - Running setup.py install for mozinfo 11:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:39 INFO - Running setup.py install for mozInstall 11:08:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Running setup.py install for mozleak 11:08:40 INFO - Running setup.py install for mozlog 11:08:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Running setup.py install for moznetwork 11:08:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Running setup.py install for mozprocess 11:08:40 INFO - Running setup.py install for mozprofile 11:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Running setup.py install for mozrunner 11:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Running setup.py install for mozscreenshot 11:08:40 INFO - Running setup.py install for moztest 11:08:40 INFO - Running setup.py install for mozversion 11:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:40 INFO - Cleaning up... 11:08:41 INFO - Return code: 0 11:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:41 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 11:08:41 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 11:08:41 INFO - Using env: {'DISPLAY': ':0', 11:08:41 INFO - 'HOME': '/home/cltbld', 11:08:41 INFO - 'LANG': 'en_US.UTF-8', 11:08:41 INFO - 'LANGUAGE': 'en_US:en', 11:08:41 INFO - 'LOGNAME': 'cltbld', 11:08:41 INFO - 'MAIL': '/var/mail/cltbld', 11:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:41 INFO - 'MOZ_NO_REMOTE': '1', 11:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:41 INFO - 'NO_EM_RESTART': '1', 11:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:41 INFO - 'PWD': '/builds/slave/test', 11:08:41 INFO - 'SHELL': '/bin/bash', 11:08:41 INFO - 'SHLVL': '1', 11:08:41 INFO - 'TERM': 'linux', 11:08:41 INFO - 'TMOUT': '86400', 11:08:41 INFO - 'USER': 'cltbld', 11:08:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:41 INFO - '_': '/tools/buildbot/bin/python'} 11:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:41 INFO - Running setup.py (path:/tmp/pip-rA2VzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:41 INFO - Running setup.py (path:/tmp/pip-iqI4nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:41 INFO - Running setup.py (path:/tmp/pip-zIP6_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:41 INFO - Running setup.py (path:/tmp/pip-bAiK02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:41 INFO - Running setup.py (path:/tmp/pip-OYwuOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:41 INFO - Running setup.py (path:/tmp/pip-PKG8Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:41 INFO - Running setup.py (path:/tmp/pip-7K_GiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:41 INFO - Running setup.py (path:/tmp/pip-Eq11bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:41 INFO - Running setup.py (path:/tmp/pip-LoL9lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:41 INFO - Running setup.py (path:/tmp/pip-SruBxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:41 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)) 11:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:41 INFO - Running setup.py (path:/tmp/pip-q21vLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:42 INFO - Running setup.py (path:/tmp/pip-2qP9Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:42 INFO - Running setup.py (path:/tmp/pip-2vnMAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:42 INFO - Running setup.py (path:/tmp/pip-moAx37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:42 INFO - Running setup.py (path:/tmp/pip-KusEl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:42 INFO - Running setup.py (path:/tmp/pip-hro6hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:42 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)) 11:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:42 INFO - Running setup.py (path:/tmp/pip-uHdzmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:42 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)) 11:08:42 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)) 11:08:42 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)) 11:08:42 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)) 11:08:42 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)) 11:08:42 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)) 11:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:42 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 11:08:42 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 11:08:42 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 11:08:42 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 11:08:42 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 11:08:42 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 11:08:44 INFO - Downloading blessings-1.6.tar.gz 11:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:44 INFO - Installing collected packages: blessings 11:08:44 INFO - Running setup.py install for blessings 11:08:44 INFO - Successfully installed blessings 11:08:44 INFO - Cleaning up... 11:08:44 INFO - Return code: 0 11:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:44 INFO - Reading from file tmpfile_stdout 11:08:44 INFO - Current package versions: 11:08:44 INFO - argparse == 1.2.1 11:08:44 INFO - blessings == 1.6 11:08:44 INFO - blobuploader == 1.2.4 11:08:44 INFO - docopt == 0.6.1 11:08:44 INFO - manifestparser == 1.1 11:08:44 INFO - mozInstall == 1.12 11:08:44 INFO - mozcrash == 0.17 11:08:44 INFO - mozdebug == 0.1 11:08:44 INFO - mozdevice == 0.48 11:08:44 INFO - mozfile == 1.2 11:08:44 INFO - mozhttpd == 0.7 11:08:44 INFO - mozinfo == 0.9 11:08:44 INFO - mozleak == 0.1 11:08:44 INFO - mozlog == 3.2 11:08:44 INFO - moznetwork == 0.27 11:08:44 INFO - mozprocess == 0.22 11:08:44 INFO - mozprofile == 0.28 11:08:44 INFO - mozrunner == 6.11 11:08:44 INFO - mozscreenshot == 0.1 11:08:44 INFO - mozsystemmonitor == 0.3 11:08:44 INFO - moztest == 0.7 11:08:44 INFO - mozversion == 1.4 11:08:44 INFO - psutil == 3.1.1 11:08:44 INFO - requests == 1.2.3 11:08:44 INFO - wsgiref == 0.1.2 11:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:44 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 11:08:44 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 11:08:44 INFO - Using env: {'DISPLAY': ':0', 11:08:44 INFO - 'HOME': '/home/cltbld', 11:08:44 INFO - 'LANG': 'en_US.UTF-8', 11:08:44 INFO - 'LANGUAGE': 'en_US:en', 11:08:44 INFO - 'LOGNAME': 'cltbld', 11:08:44 INFO - 'MAIL': '/var/mail/cltbld', 11:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:44 INFO - 'MOZ_NO_REMOTE': '1', 11:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:44 INFO - 'NO_EM_RESTART': '1', 11:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:44 INFO - 'PWD': '/builds/slave/test', 11:08:44 INFO - 'SHELL': '/bin/bash', 11:08:44 INFO - 'SHLVL': '1', 11:08:44 INFO - 'TERM': 'linux', 11:08:44 INFO - 'TMOUT': '86400', 11:08:44 INFO - 'USER': 'cltbld', 11:08:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:44 INFO - '_': '/tools/buildbot/bin/python'} 11:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 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)) 11:08:45 INFO - Cleaning up... 11:08:45 INFO - Return code: 0 11:08:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:08:45 INFO - Using env: {'DISPLAY': ':0', 11:08:45 INFO - 'HOME': '/home/cltbld', 11:08:45 INFO - 'LANG': 'en_US.UTF-8', 11:08:45 INFO - 'LANGUAGE': 'en_US:en', 11:08:45 INFO - 'LOGNAME': 'cltbld', 11:08:45 INFO - 'MAIL': '/var/mail/cltbld', 11:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:45 INFO - 'MOZ_NO_REMOTE': '1', 11:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:45 INFO - 'NO_EM_RESTART': '1', 11:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:45 INFO - 'PWD': '/builds/slave/test', 11:08:45 INFO - 'SHELL': '/bin/bash', 11:08:45 INFO - 'SHLVL': '1', 11:08:45 INFO - 'TERM': 'linux', 11:08:45 INFO - 'TMOUT': '86400', 11:08:45 INFO - 'USER': 'cltbld', 11:08:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:45 INFO - '_': '/tools/buildbot/bin/python'} 11:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:45 INFO - Downloading/unpacking jsonschema 11:08:45 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 11:08:45 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 11:08:45 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 11:08:45 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 11:08:45 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 11:08:45 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 11:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:47 INFO - Downloading/unpacking functools32 (from jsonschema) 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:47 INFO - warning: no files found matching '*.txt' 11:08:47 INFO - no previously-included directories found matching 'build' 11:08:47 INFO - no previously-included directories found matching 'dist' 11:08:47 INFO - no previously-included directories found matching '.git*' 11:08:47 INFO - Installing collected packages: jsonschema, functools32 11:08:47 INFO - Running setup.py install for functools32 11:08:47 INFO - warning: no files found matching '*.txt' 11:08:47 INFO - no previously-included directories found matching 'build' 11:08:47 INFO - no previously-included directories found matching 'dist' 11:08:47 INFO - no previously-included directories found matching '.git*' 11:08:47 INFO - Successfully installed jsonschema functools32 11:08:47 INFO - Cleaning up... 11:08:47 INFO - Return code: 0 11:08:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:08:47 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')]} 11:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:47 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')]} 11:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:47 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 0x7f02f7c8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, '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-1464803122.897397-1642509559', '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 11:08:47 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 11:08:47 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 11:08:47 INFO - Using env: {'DISPLAY': ':0', 11:08:47 INFO - 'HOME': '/home/cltbld', 11:08:47 INFO - 'LANG': 'en_US.UTF-8', 11:08:47 INFO - 'LANGUAGE': 'en_US:en', 11:08:47 INFO - 'LOGNAME': 'cltbld', 11:08:47 INFO - 'MAIL': '/var/mail/cltbld', 11:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:47 INFO - 'MOZ_NO_REMOTE': '1', 11:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:47 INFO - 'NO_EM_RESTART': '1', 11:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:47 INFO - 'PWD': '/builds/slave/test', 11:08:47 INFO - 'SHELL': '/bin/bash', 11:08:47 INFO - 'SHLVL': '1', 11:08:47 INFO - 'TERM': 'linux', 11:08:47 INFO - 'TMOUT': '86400', 11:08:47 INFO - 'USER': 'cltbld', 11:08:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:47 INFO - '_': '/tools/buildbot/bin/python'} 11:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:47 INFO - Downloading/unpacking flake8 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:47 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 11:08:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:50 INFO - no previously-included directories found matching 'docs/_build' 11:08:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:50 INFO - Running setup.py install for pep8 11:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:50 INFO - no previously-included directories found matching 'docs/_build' 11:08:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:08:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:50 INFO - Cleaning up... 11:08:50 INFO - Return code: 0 11:08:50 INFO - Running post-action listener: _resource_record_post_action 11:08:50 INFO - Running post-action listener: _start_resource_monitoring 11:08:50 INFO - Starting resource monitoring. 11:08:50 INFO - ##### 11:08:50 INFO - ##### Finished create-virtualenv step (success) 11:08:50 INFO - ##### 11:08:50 INFO - ##### 11:08:50 INFO - ##### Running install step. 11:08:50 INFO - ##### 11:08:50 INFO - Running pre-action listener: _resource_record_pre_action 11:08:50 INFO - Running main action method: install 11:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:50 INFO - Reading from file tmpfile_stdout 11:08:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:50 INFO - Reading from file tmpfile_stdout 11:08:50 INFO - Output received: 11:08:50 INFO - Usage: mozinstall [options] installer 11:08:50 INFO - Options: 11:08:50 INFO - -h, --help show this help message and exit 11:08:50 INFO - -d DEST, --destination=DEST 11:08:50 INFO - Directory to install application into. [default: 11:08:50 INFO - "/builds/slave/test"] 11:08:50 INFO - --app=APP Application being installed. [default: firefox] 11:08:50 INFO - mkdir: /builds/slave/test/build/application 11:08:50 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'] 11:08:50 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 11:09:07 INFO - Reading from file tmpfile_stdout 11:09:07 INFO - Output received: 11:09:07 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:07 INFO - Running post-action listener: _resource_record_post_action 11:09:07 INFO - ##### 11:09:07 INFO - ##### Finished install step (success) 11:09:07 INFO - ##### 11:09:07 INFO - ##### 11:09:07 INFO - ##### Running run-tests step. 11:09:07 INFO - ##### 11:09:07 INFO - Running pre-action listener: _resource_record_pre_action 11:09:07 INFO - Running main action method: run_tests 11:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:07 INFO - Python 2.7.3 11:09:07 INFO - Return code: 0 11:09:07 INFO - grabbing minidump binary from tooltool 11:09:07 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')]} 11:09:07 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 0x11589c0>, '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 0x11598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1159d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:07 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 11:09:07 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 11:09:07 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 11:09:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:07 INFO - Return code: 0 11:09:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:09:08 INFO - Return code: 0 11:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:09:08 INFO - Using env: {'DISPLAY': ':0', 11:09:08 INFO - 'HOME': '/home/cltbld', 11:09:08 INFO - 'LANG': 'en_US.UTF-8', 11:09:08 INFO - 'LANGUAGE': 'en_US:en', 11:09:08 INFO - 'LOGNAME': 'cltbld', 11:09:08 INFO - 'MAIL': '/var/mail/cltbld', 11:09:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:08 INFO - 'MOZ_NO_REMOTE': '1', 11:09:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:08 INFO - 'NO_EM_RESTART': '1', 11:09:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:08 INFO - 'PWD': '/builds/slave/test', 11:09:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:08 INFO - 'SHELL': '/bin/bash', 11:09:08 INFO - 'SHLVL': '1', 11:09:08 INFO - 'TERM': 'linux', 11:09:08 INFO - 'TMOUT': '86400', 11:09:08 INFO - 'USER': 'cltbld', 11:09:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464803122.897397-1642509559', 11:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:08 INFO - '_': '/tools/buildbot/bin/python'} 11:09:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/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 11:09:08 INFO - mozversion application_buildid: 20160601083038 11:09:08 INFO - mozversion application_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 11:09:08 INFO - mozversion application_display_name: Nightly 11:09:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:08 INFO - mozversion application_name: Firefox 11:09:08 INFO - mozversion application_remotingname: firefox 11:09:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:08 INFO - mozversion application_vendor: Mozilla 11:09:08 INFO - mozversion application_version: 49.0a1 11:09:08 INFO - mozversion platform_buildid: 20160601083038 11:09:08 INFO - mozversion platform_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 11:09:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:08 INFO - mozversion platform_version: 49.0a1 11:09:08 INFO - using testdate: 1464804548 11:09:08 INFO - actual date: 1464804548 11:09:08 INFO - starting webserver on 'localhost:39607' 11:09:08 INFO - SUITE-START | Running 2 tests 11:09:08 INFO - TEST-START | dromaeo_css 11:09:08 INFO - operating with platform_type : linux_ 11:09:08 INFO - Initialising browser for dromaeo_css test... 11:09:08 INFO - TEST-INFO | started process 2355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCgoG4C/profile http://localhost:39607/getInfo.html) 11:09:13 INFO - PROCESS | 2355 | __metrics Screen width/height:1600/1200 11:09:13 INFO - PROCESS | 2355 | colorDepth:24 11:09:13 INFO - PROCESS | 2355 | Browser inner width/height: 1024/697 11:09:13 INFO - PROCESS | 2355 | __metrics 11:09:14 ERROR - PROCESS | 2355 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:09:15 INFO - TEST-INFO | 2355: exit 0 11:09:15 INFO - Browser initialized. 11:09:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:15 INFO - TEST-INFO | started process 2564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCgoG4C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:26 INFO - PROCESS | 2564 | RSS: Main: 167092224 11:09:26 INFO - PROCESS | 2564 | 11:10:16 INFO - PROCESS | 2564 | 1464804616482 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] 11:12:23 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39607/tests/dromaeo/cssquery-ext.html) 11:12:24 INFO - PROCESS | 2564 | RSS: Main: 170491904 11:12:24 INFO - PROCESS | 2564 | 11:15:26 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-ext.html (next: http://localhost:39607/tests/dromaeo/cssquery-jquery.html) 11:15:27 INFO - PROCESS | 2564 | RSS: Main: 169533440 11:15:27 INFO - PROCESS | 2564 | 11:18:29 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39607/tests/dromaeo/cssquery-mootools.html) 11:18:29 INFO - PROCESS | 2564 | RSS: Main: 171126784 11:18:29 INFO - PROCESS | 2564 | 11:21:31 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39607/tests/dromaeo/cssquery-prototype.html) 11:21:32 INFO - PROCESS | 2564 | RSS: Main: 168968192 11:21:32 INFO - PROCESS | 2564 | 11:24:34 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39607/tests/dromaeo/cssquery-yui.html) 11:24:35 INFO - PROCESS | 2564 | RSS: Main: 170897408 11:24:35 INFO - PROCESS | 2564 | 11:27:37 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:39607/tests/dromaeo/cssquery-yui.html (next: http://localhost:39607/tests/dromaeo/cssquery-dojo.html) 11:27:38 INFO - PROCESS | 2564 | RSS: Main: 171798528 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | __start_tp_report 11:27:38 INFO - PROCESS | 2564 | _x_x_mozilla_page_load 11:27:38 INFO - PROCESS | 2564 | _x_x_mozilla_page_load_details 11:27:38 INFO - PROCESS | 2564 | |i|pagename|runs| 11:27:38 INFO - PROCESS | 2564 | |0;dojo.html;3082.8920987765428;3099.5970523831897;3146.0247323329754;3152.921176970575;3161.620605527337;5410.431904650014;5417.972910135449;5434.755436005385;5480.972595137018;5483.533899618537;5253.474652534745;5315.548178404831;5418.8916221675545;5457.263269458622;5457.808976685817;4891.217405215166;4896.241082632188;4930.161872481687;4962.057209130254;5046.949530504703;510.27284385037166;4926.679765815211;5027.195648696209;5044.596432285409;5047.242913562958;4786.688865223767;4983.152864013126;4991.151504244269;4995.225740010304;5043.924341134868;4988.152014157602;4999.125153098194;5005.049040682259;5020.246962955549;5058.165402708549;4871.244957031666;4911.45973942866;4916.729579873106;4977.576905962997;4987.226979818098;5269.657472264329;5336.653117547347;5347.759350829222;5361.115415956362;5381.0852155133725;5850.12248162779;5881.088431293157;5886.20536227608;5888.823335299948;5975.850603734898;5632.746526406321;5808.332041815203;5848.41515848416;5872.295324561037;5906.527477801766;5485.6982865942355;5492.917606235909;5493.642913210629;5500.1749737539285;5523.033469142884;5779.595428320062;5974.611650242808;5990.520758339409;5999.580029397987;5999.940000599938;5648.491635752802;5651.6043876928225;5763.538916886723;5770.509506691894;5786.681732504752;5845.064789633639;5941.58408911372;5948.405159484017;5954.791582294599;5957.314908785545;5816.272965879265;5853.970730146322;5923.111533270044;5928;5928.67392293428;5841.123831425235;5842.211301474332;5851.707414629252;5917.786853695068;5955.13650520672;4465.843695470643;4466.062126953311;4476.903158726068;4491.124230775033;4506.639468842484;3891.591382904811;3911.8630847920185;3934.7442416243425;3960.3663413853646;3975.4036894465485;5381.704006279692;5533.22534845122;5539.279893613804;5581.190727344512;5605.5515558755205;5965.373635768268;5965.522758179422;5974.1934838796205;5984.1921340618455;5987.520998320124;5364.222187782828;5549.472800083986;5596.384397716248;5618.073017951992;5625.943740562542;5010.5240002199735;5089.211172268304;5093.2105523643895;5100.4899510049445;5130.9230361544605;5733.512651424592;6101.054336577838;6125.96937015321;6130.877382452326;6136.386361363917;5808.854778630568;5840.912386314124;5844.12338149281;5897.203877476486;5912.172295878494;6044.486218671462;6051.33435322123;6055.727492262947;6059.969700151471;6063.120847477003;5531.2532808072;5743.971280143573;5762.683052432157;5763.193152958505;5804.82585522435;5924.229850119457;6006.87986240264;6008.819735407945;6012.068129439944;6063.757449702139;5845.795397161079;5847.649141051551;5875.177475153397;5877.588568800314;5880.470757631833;5536.141898005815;5551.9722401387735;5560.555155587463;5821.126830975219;5859.414058594277;5430.647007944471;5462.617616766788;5490.533304669148;5497;5596.776128954796;5606.803761868315;5627;5640.520555752642;5654.660720356792;5674.546036317167;5428.511433970962;5522.30971128609;5572.080606700011;5576.944230557642;5616.85957851057 11:27:38 INFO - PROCESS | 2564 | |1;ext.html;575.2291928815387;606.4451027310014;617.5245061302797;639.2648454277581;664.3788058165619;38820;43259.35110973334;43341.78329108358;43424;43510.782446087804;35427.2914541709;35510;35647.2870542589;35883.641163588356;35934.64065359346;8750.95624521878;8953.865692014626;8971.910280897206;8972.192502674758;8988.415752976069;8800.779980500474;8898.332625053115;8901.73294801157;8908.331875109361;8915.108489151098;8846.955765221164;8908;8916.554172291391;8919.24186444153;8921.95539022304;8849.823003539957;8861.202491775739;8885.155910188554;8903.287736981027;8903.554822258926;8833.381663283573;8838.072002439716;8905.154010369004;8928.24109950655;8946.68686595966;33205;41350.172996540205;41773.582264177276;41861.790691046655;41882;3373.325334932999;3540.6813386795056;3641.18073433478;3691.778493290384;3725.8509659613583;31710.207244818834;32028.519572206435;32587.18532036694;33512.29891228702;34395.31209375799;3895.4156876468473;3903;4018.1561872006623;4079.77561234132;4155.10665206982;137638;138867;139126;139312.30343848217;139358;65226;65751.67124164349;65877;66011.66994164999;66101.66949165224;70338.64830675814;70710.2928970714;70878.64560677164;71080.2891971084;71122.64438677774;16222.756658650129;17152.742708859376;17467.82532174662;17489.91255043742;17561.912190438965;13396.732065358834;13541.458341666223;13585.116967397285;13594.32028398576;13624.591262261949;20275.493112672302;20342.288019919233;20771.169153234005;20800.271990480564;20803.58392832135;7323.377512911356;7501.924980750232;7641.923580764233;7677.347425468786;7702.229777022253;943.4009404028492;1032.7056788815153;1069.1660504806264;1117.7317443813427;1151.8329842172839;33199.83400082984;33564.664353356646;33695.326093478485;33936.11543018871;33981.490277645855;1165.4813607944552;1178.3106882473678;1187.5427960235372;1245.6263121063826;1260.1619922751267;16966.91516542434;17624.471265862045;17706.734398984026;17713.743284412747;17756.28974840992;521366;522569;524135;527150;528495;60367;61304;61314;61369.38630613726;61559.38440615626;1325.3174615073244;1368.1244003837553;1368.5210176438168;1398.9230592317317;1400.5308221745624;31747;32876.34247315088;33054.338913222084;33219;33325.16687082842;53007.469925300255;53161.67095822635;53350.73324633352;53379.73310133425;53418;454695;456287;456545;458314;458907;44195.33706994462;44681.32978005268;45662.77168614136;45690.54309456863;45916.54083459123;48775.756121220584;49326.50673493219;49718.50281497283;50530;50582.24126638177;38618.6138138615;39179.41230881596;39697;39725.40411893766;39864.402033970095;42250.577494224664;42518.574814251464;42606.36090458584;42614.78692606641;42937;42131;42361;43249.78375108104;43275.567244327154;43532.56467435285;35459.29081418409;38211.80894095512;38215;38541.42187867128;38792.41811372888;29125.271868202617;29289.560656589743;29515.262118446353;29554.078984865915;29627.703722962495 11:27:38 INFO - PROCESS | 2564 | |2;jquery.html;377.1495278147776;383.18381846666597;394.9723519353645;400.96190861868115;407.8592885454517;16807.83192168078;19377.418677439666;19647.115879785408;19788.802111978875;19834.90082549589;18858.71711924322;19222.13500392482;19222.231110755554;19264.22943082275;19583.902080489614;5488.615796894199;5630.831075067745;5727.770889164429;5782.3350314713925;5850.502707269887;5649.519790817785;5716.28546431696;5726.713664316789;5744.856378590548;5759.4816466518005;5493.23094766733;5667.4615911488345;5699.202111704344;5732.2261494698305;5738.8278351649515;5696.743646535916;5700.515456186229;5708.257926469574;5732.48407643312;5744.569157313197;4959;5072.898542029176;5082.110630639623;5082.263071854597;5110.003549307887;20443.79556204434;21664.458388540414;21789.782102178935;21905;22507.32478025662;2125.171183238538;2261.118163916074;2324.4886125052462;2522.2433270019105;2732.180345896223;10049.34679245854;10185.643502477451;10565.841512377321;10572.78854422915;10748.838767418494;1873.8313551780268;1924.6824273994773;2036.4297996560986;2051.1795281887216;2056.958860822775;79160;79267.20732792656;80013.59993199997;80322.19677803264;80723.19276807274;10719.946400268105;10876.782464350668;10884.129269658408;11034.062104721188;11222.887771122347;15250.161241131622;15441.613959650875;15497.380104795908;15509.922450387676;15537.766933496006;7907.604619768988;8148.22591853773;8311.127331630092;8319.126491718282;8394.87407688873;7938.5236885787035;8095.473794203475;8125.1062383137805;8215.712450064219;8218.506889586644;4689.249720044844;4709.152352576501;4721.220998535272;4726.95273047272;4859.319695242669;1953.9218431262875;1994.7107669388147;1997.460685614876;2000.6398848207461;2039.7450318710162;875.382855087162;1008.2538921198407;1026.2662196529518;1048.6749107776614;1113.7414721364805;18768.249270029046;19157.425277241706;19388.806111938982;19467.415977520697;19896;1004.6182450668699;1015.7155996321042;1022.5602990713916;1037.4242295526055;1126.189143816451;10730.141588672888;10874.46333334982;10921.617743379102;11014.724631884106;11034.558617655204;492325;502099;502278;504547;510983;60483;74540.62729686317;95278;95453;99774;996.0935548650693;1022.4632068164422;1027.753339198602;1045.5660900726266;1064.9414282214552;17459.82540174582;17857.642847143245;18086.5478363042;18173;18552.721709174104;29008.12975610735;36072.639273606925;40732.79633601813;40985.795071024455;41336.37995430131;51638;52774.47225527695;53615.19577206267;59970;62280.68859655673;7972.92027079745;8348.958255208685;8408.87386689188;8534.317254619491;8610.655573777229;9529.714108576754;12689.428975695932;12906.096573239784;12954.417051232529;13210.734650806722;11606.361650108987;11700.239484433485;11722.58970936013;11785.587504437304;11879;5193.61047921415;10775.461226938778;10993;11177.776444470903;11290.491927863102;11157.49791259379;11221.877812218712;11495.482703278205;11648.76702465929;11710.590129345432;8383.580820958805;8537.615807288563;8571.871421928801;8583.957080214559;8812.91187088121;8467.068622451648;11193.048590869541;11427.485763140845;11571.942140289244;11781.705457363634 11:27:38 INFO - PROCESS | 2564 | |3;mootools.html;1506.5630967019565;1512.9319180636871;1684.5367523930918;1820.6904826179539;1836.5316844204726;7916.881246781303;8539.48763074216;8582.356323275755;9173.220276276516;9179.173874351307;8463.576821158933;8604.39769216155;8605.268552173056;8697.1302869713;8724.956375218115;2318.849274797137;2348.471593891369;2356.1046802215133;2359.0210062823908;2365.373176108324;2310.849794763343;2314.6990891184123;2364.3143488388346;2366.2546297916188;2371.158238825218;2302.1712183613886;2307.0310469602805;2317.385892738426;2334.7898689117974;2345;2292.449812045097;2301.6892719482908;2325.348902307348;2326.8603883766946;2347.929562113139;2274.6701728249313;2288.485090854561;2288.9885550572308;2291.4958709083976;2292.32376448948;8888.822223555493;8965.910340896573;8967.372283940127;8968.237699795525;8985.595648195847;5257.86855328616;5336.039512887679;5384.461553844623;5385.246065550826;5388.326459192601;3162.114607909789;3196.0891146023505;3352.664733526628;3412.2493051528622;3413.2661477782394;1080.1304949515636;1103.167108832826;1119.6696974392573;1128.841962125303;1140.3727949627755;12588.68528286791;12803.167794093353;12937.159084659466;12941.288229147392;12941.48234070636;4659.743714095757;4724.834630787906;4828.46886842447;4841.709497430165;4853.466118726938;10661.893381066246;10665.093467055232;10672.519736611872;10682.51928663212;10683.038526532493;5416.052190866582;5440.156775699694;5447.428020057916;5478.726063696799;5489.862753431196;4291.892702682458;4819.975900120477;4959.70241785494;4971.801127954841;5016.648834581617;4081.0288374294587;4096.730013695764;4130.070734084807;4183.456150700389;4188.973701443166;1248.7502499500135;1264.2983144354787;1271.8155867399175;1281.6795801049739;1287.0411543400228;928.893177284621;964.9662261820943;1023.8771347438355;1047.7747284333905;1059.0838924330399;6146.877062458726;6312.779052733133;6358.745650173942;6371.012493063583;6387.265464471645;429.5875959079256;433.1358938916881;437.7767338657244;438.8639521748268;1006.2453160129902;4147.585241475888;4225.154969006211;4230.915381692349;4261.850835220753;4312;11067.72330691723;11455.255408398427;11473.827892581618;11489.138314626436;11514.596989105341;10481.161507079416;10815.78368432627;10821.783564328669;10843.891561084445;11334.489947952361;8132.5933703314595;8270.627821748036;8282.544460054634;8451.323894088458;8459.154084591615;6147.415995480422;6266.185395898504;6320.083587879823;6347.016212487072;6354.650494222862;10266.395079479;10402.427866467417;10480.475976201313;10559.788804224027;10582.682519524427;10507.894921050998;10605.840912386166;10694.983976522219;10729.141668666332;10758.40828754426;7408.148062972827;8201.13888041771;8544.102869198645;8556.57217139153;8725.25835303981;8796.164364385373;8815.911840881508;8826.24976876947;8840.55797210124;8845.690400836198;7855.410844186823;8020.516204501952;8035.397345199017;8118.715844945398;8126.309263712415;7721.961390193013;7859.567723775019;7917.445778795429;7991.64037618297;8031.277185053374;7147.892781608384;7165.928340716735;7199.280071992759;7309.926900730925;7318.085239345082;5395.730213489388;5402.270693456333;5414.539764120094;5437.02133615953;5558.3607885092115;5258.737063146751;5306.177542480922;5371.579136475226;5394.433584473731;5411.2965314508865 11:27:38 INFO - PROCESS | 2564 | |4;prototype.html;331.2844256406162;335.4280950978582;337.9831008449577;339.441618537506;342;5602.551795856332;5679.182661548306;5686.402927692595;5700;5709.286339207599;5632.746526406311;5633.352164501083;5652.886942261152;5661.094224924013;5663.122216056508;4181.519125300599;4234.280172370704;4322.567743225683;4349.630281426067;4370.4755429348525;4345;4346.8913277168;4350.956490435103;4354.608085272325;4387.670924680646;4309.332053531708;4323.610875021247;4323.848665296715;4332.84835030774;4348.543402942693;4203.958369730689;4239.258129827268;4333.978330108361;4338.631216346615;4343.174796788631;3799.525059367579;3818.8281527331337;3822.2164456286396;3827.942580861289;3832.3868181090893;5357.223202635596;5400.675959442446;5411.540019098381;5411.864703382447;5497.862553436196;4942.811886333295;4949.925751113737;4975.552200301954;5003.499650034967;5044.672096313728;5744.511716504102;5786.46658635462;5793.652380857162;5799.884002319972;5858.443447872488;4188.979055104735;4239.788010599457;4256.808443620044;4259.51015633203;4260.850870219559;5758.62568933018;6046.516278697738;6066.4540191382985;6115.388461153893;6129.908051379233;4176.644985176234;4195.307774217281;4196.426340122454;4204.642605378577;4230.5769423057445;4220.451341325669;4224.957750422518;4249.511306199826;4262.509811371732;4263.317869140985;4722.315264286659;4825.420949486084;4884.778805298675;4911.63162762787;4916.852494425173;5831.883362332815;5861.648301101947;5872.35913733488;5886.70418536771;5958.821235362946;1457.9575603443589;1464.6045567696663;1472.271225743264;1476.9409223631149;1483.7848511965703;919.8206349761866;925.5372313843078;932.6689025395887;939.1641439119189;940.7789169545151;4990.750462476862;4999.850004499871;5013.874653133701;5029.245613158056;5094.821681241138;5330.786768529216;5352.598555108382;5359.410464848864;5381.470708766873;5419.268398766195;4847.975760121177;4978.386347167693;5079.771410286546;5104.387473503203;5114.693118412907;2848.091778508363;2865.9713402866123;2866.426714657077;2886.5381538953666;2901.2166714986834;5592.769590690042;5593.916091258634;5610.382857885629;5621.7189140542805;5625.718714064362;5188.481151884781;5515.448455154453;5522.171674248814;5526.613137080446;5549.361823390362;5559.416261292587;5588.804391846266;5595.188697638901;5598.748056337393;5607.467290607386;5119.385673719029;5266.920996184984;5320.361556613077;5408.296921400193;5438.721900353493;5265.552428043659;5276.973615131899;5277.894442111213;5284.762185701729;5292.576593872558;5437.972810135924;5442.755076021509;5479.369872464558;5482.917756233739;5562.944370556243;3807.010177353963;3812.3328417527377;3861.864834730771;3865.2849222893856;4208.200441916026;5848.766049358148;5878.29460464747;6047.5464340173785;6051.394860513913;6097.542684298606;5896.7936122235515;5913.34953155144;5951.851203719942;5959.284885813557;5963.135345374983;5829.970850145722;5871.354151043296;5916.230889984275;5918.852028699317;5939.643621382558;5631;5758.942410576008;5776.624519406393;5826.941730582809;5831.4168583141345;5790.494471437372;5905.586608937333;5912.526997840077;5922.378150294157;5922.703864806828;5575.4424557543925;5681.261436013292;5785.553611597101;5829.163813398766;5842.1820945068575 11:27:38 INFO - PROCESS | 2564 | |5;yui.html;737.8413641067169;772.4416583728221;776.6272189349112;781.5037451218478;784.7841843493043;14040.929795351021;14578.489752858652;15017.549473515784;15160.62098447538;15398.153101579408;14057.367418466194;14067.507637232698;14073.155610663342;14184.43262269508;14201.715965680705;685.3454950522264;802.6067227058728;810.4934415990007;823.0575990490885;825.8637324841394;821.4660470694067;822.3092602214139;823.3454403749034;823.4647479138578;824.8391563645091;851.6040041380757;852.8720691896203;853.4154104438479;853.6372041882175;855.1320409784043;848.9151084891523;849.7790574450626;850.0394554153797;850.230541360064;852.6461518469828;612.4120843989775;617.5831313863124;618.0821480102045;618.9628622282632;620.751699320271;14106.71786564263;14118.082324648865;14127.858721412756;14180.22008789516;14183.219922904236;13463.461461541625;13592.38834252461;13676.521321753691;13688.384022719001;13951.372188251553;11385.886141138566;11513.884861151366;11575.710607234802;11577.594784182598;11608.709782255426;3781.9054523636855;3802.9619703802887;3811.1996480739076;3837.6546110849877;3954.5452272988687;57062;58032.419675803125;58337.124943125884;58377.416225838046;58555.41444585542;10340.586376545005;10478.685639430829;10551.103156231653;10591.060746943236;10762.3542587445;19289.228430862888;19308.80691193098;19414.514637134183;19422.70865937012;19514.414567562995;8168.469049511763;8202.876956845652;8265.380096492787;8279.254867061993;8299.211574900375;4659.464161621389;4659.464161621389;4669.883252918704;4670.929936050962;4745.715257084586;3303.8513266903046;3370.898873033813;3402.3365443738235;3402.438597631363;3418.3505134024954;620.203039094761;626.1077963901422;632.8354627796806;640.0495264532166;655.7147640776277;642.601587016053;690.9670043285321;772.4052479590796;773.1649818196335;792.6036981509245;9371.718848434557;9418.29362797793;9604.183644390305;9658.806823863484;9777.168940640126;661.927677162999;691.7267679266662;744.780289814506;755.6033082631662;761.5544906229807;4316.417283666665;4448.5551444855255;4472.776361181993;4476.149531588988;4515.503294637587;66621.33378666152;67073.6646316775;67301.3269867295;68077;68079.65960170167;58812;60042;60087.399126009055;60213.39786602078;61622.075668865;52480;52900.735496322275;53485;57176;57821.71089144528;9221.677241296522;9558.091981261769;9575.808483830424;9601.135897769234;9672.854907176257;36550.634493654725;37173.814130929175;37229;37516.81241593775;38460;48257.5174248253;51119.488805111476;51129;51358.22962655489;51419;11981.940090299493;12386.81419778686;12426.192297500633;12787.680307992374;13014.089013768946;12364.690882727644;13405.128666636638;13564.79652805189;13878.16730996103;14343.067700599428;11155.776884462428;11302.321860688386;11636.94181529087;11675.416229188337;11991.340476273888;10929.508172132115;11183.384913829492;11849.940750296193;12352.197107188003;12430.502779888704;11058.170637202082;11957.282563046245;12537.789177478542;12770.106092573431;13400.530981415994;10237.616505383408;10261.17910567138;10412.114970227616;10877.67366978992;11315.490802913724;11646.301221926711;11692.590759323382;11728.94135529317;11776.097243670423;11957.342346171044 11:27:38 INFO - PROCESS | 2564 | __end_tp_report 11:27:38 INFO - PROCESS | 2564 | __start_cc_report 11:27:38 INFO - PROCESS | 2564 | _x_x_mozilla_cycle_collect,357 11:27:38 INFO - PROCESS | 2564 | __end_cc_report 11:27:38 INFO - PROCESS | 2564 | __startTimestamp1464805658153__endTimestamp 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | ------- Summary: start ------- 11:27:38 INFO - PROCESS | 2564 | Number of tests: 6 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#0] dojo.html Cycles:165 Average:5402.80 Median:5581.19 stddev:739.14 (13.2%) stddev-sans-first:718.65 11:27:38 INFO - PROCESS | 2564 | Values: 3082.9 3099.6 3146.0 3152.9 3161.6 5410.4 5418.0 5434.8 5481.0 5483.5 5253.5 5315.5 5418.9 5457.3 5457.8 4891.2 4896.2 4930.2 4962.1 5046.9 510.3 4926.7 5027.2 5044.6 5047.2 4786.7 4983.2 4991.2 4995.2 5043.9 4988.2 4999.1 5005.0 5020.2 5058.2 4871.2 4911.5 4916.7 4977.6 4987.2 5269.7 5336.7 5347.8 5361.1 5381.1 5850.1 5881.1 5886.2 5888.8 5975.9 5632.7 5808.3 5848.4 5872.3 5906.5 5485.7 5492.9 5493.6 5500.2 5523.0 5779.6 5974.6 5990.5 5999.6 5999.9 5648.5 5651.6 5763.5 5770.5 5786.7 5845.1 5941.6 5948.4 5954.8 5957.3 5816.3 5854.0 5923.1 5928.0 5928.7 5841.1 5842.2 5851.7 5917.8 5955.1 4465.8 4466.1 4476.9 4491.1 4506.6 3891.6 3911.9 3934.7 3960.4 3975.4 5381.7 5533.2 5539.3 5581.2 5605.6 5965.4 5965.5 5974.2 5984.2 5987.5 5364.2 5549.5 5596.4 5618.1 5625.9 5010.5 5089.2 5093.2 5100.5 5130.9 5733.5 6101.1 6126.0 6130.9 6136.4 5808.9 5840.9 5844.1 5897.2 5912.2 6044.5 6051.3 6055.7 6060.0 6063.1 5531.3 5744.0 5762.7 5763.2 5804.8 5924.2 6006.9 6008.8 6012.1 6063.8 5845.8 5847.6 5875.2 5877.6 5880.5 5536.1 5552.0 5560.6 5821.1 5859.4 5430.6 5462.6 5490.5 5497.0 5596.8 5606.8 5627.0 5640.5 5654.7 5674.5 5428.5 5522.3 5572.1 5576.9 5616.9 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#1] ext.html Cycles:180 Average:55809.70 Median:42190.79 stddev:109463.46 (259.4%) stddev-sans-first:109691.98 11:27:38 INFO - PROCESS | 2564 | Values: 575.2 606.4 617.5 639.3 664.4 38820.0 43259.4 43341.8 43424.0 43510.8 35427.3 35510.0 35647.3 35883.6 35934.6 8751.0 8953.9 8971.9 8972.2 8988.4 8800.8 8898.3 8901.7 8908.3 8915.1 8847.0 8908.0 8916.6 8919.2 8922.0 8849.8 8861.2 8885.2 8903.3 8903.6 8833.4 8838.1 8905.2 8928.2 8946.7 33205.0 41350.2 41773.6 41861.8 41882.0 3373.3 3540.7 3641.2 3691.8 3725.9 31710.2 32028.5 32587.2 33512.3 34395.3 3895.4 3903.0 4018.2 4079.8 4155.1 137638.0 138867.0 139126.0 139312.3 139358.0 65226.0 65751.7 65877.0 66011.7 66101.7 70338.6 70710.3 70878.6 71080.3 71122.6 16222.8 17152.7 17467.8 17489.9 17561.9 13396.7 13541.5 13585.1 13594.3 13624.6 20275.5 20342.3 20771.2 20800.3 20803.6 7323.4 7501.9 7641.9 7677.3 7702.2 943.4 1032.7 1069.2 1117.7 1151.8 33199.8 33564.7 33695.3 33936.1 33981.5 1165.5 1178.3 1187.5 1245.6 1260.2 16966.9 17624.5 17706.7 17713.7 17756.3 521366.0 522569.0 524135.0 527150.0 528495.0 60367.0 61304.0 61314.0 61369.4 61559.4 1325.3 1368.1 1368.5 1398.9 1400.5 31747.0 32876.3 33054.3 33219.0 33325.2 53007.5 53161.7 53350.7 53379.7 53418.0 454695.0 456287.0 456545.0 458314.0 458907.0 44195.3 44681.3 45662.8 45690.5 45916.5 48775.8 49326.5 49718.5 50530.0 50582.2 38618.6 39179.4 39697.0 39725.4 39864.4 42250.6 42518.6 42606.4 42614.8 42937.0 42131.0 42361.0 43249.8 43275.6 43532.6 35459.3 38211.8 38215.0 38541.4 38792.4 29125.3 29289.6 29515.3 29554.1 29627.7 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#2] jquery.html Cycles:180 Average:28838.25 Median:12384.22 stddev:82660.16 (667.5%) stddev-sans-first:82864.42 11:27:38 INFO - PROCESS | 2564 | Values: 377.1 383.2 395.0 401.0 407.9 16807.8 19377.4 19647.1 19788.8 19834.9 18858.7 19222.1 19222.2 19264.2 19583.9 5488.6 5630.8 5727.8 5782.3 5850.5 5649.5 5716.3 5726.7 5744.9 5759.5 5493.2 5667.5 5699.2 5732.2 5738.8 5696.7 5700.5 5708.3 5732.5 5744.6 4959.0 5072.9 5082.1 5082.3 5110.0 20443.8 21664.5 21789.8 21905.0 22507.3 2125.2 2261.1 2324.5 2522.2 2732.2 10049.3 10185.6 10565.8 10572.8 10748.8 1873.8 1924.7 2036.4 2051.2 2057.0 79160.0 79267.2 80013.6 80322.2 80723.2 10719.9 10876.8 10884.1 11034.1 11222.9 15250.2 15441.6 15497.4 15509.9 15537.8 7907.6 8148.2 8311.1 8319.1 8394.9 7938.5 8095.5 8125.1 8215.7 8218.5 4689.2 4709.2 4721.2 4727.0 4859.3 1953.9 1994.7 1997.5 2000.6 2039.7 875.4 1008.3 1026.3 1048.7 1113.7 18768.2 19157.4 19388.8 19467.4 19896.0 1004.6 1015.7 1022.6 1037.4 1126.2 10730.1 10874.5 10921.6 11014.7 11034.6 492325.0 502099.0 502278.0 504547.0 510983.0 60483.0 74540.6 95278.0 95453.0 99774.0 996.1 1022.5 1027.8 1045.6 1064.9 17459.8 17857.6 18086.5 18173.0 18552.7 29008.1 36072.6 40732.8 40985.8 41336.4 51638.0 52774.5 53615.2 59970.0 62280.7 7972.9 8349.0 8408.9 8534.3 8610.7 9529.7 12689.4 12906.1 12954.4 13210.7 11606.4 11700.2 11722.6 11785.6 11879.0 5193.6 10775.5 10993.0 11177.8 11290.5 11157.5 11221.9 11495.5 11648.8 11710.6 8383.6 8537.6 8571.9 8584.0 8812.9 8467.1 11193.0 11427.5 11571.9 11781.7 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#3] mootools.html Cycles:180 Average:5956.77 Median:2372.57 stddev:3424.96 (144.4%) stddev-sans-first:3418.24 11:27:38 INFO - PROCESS | 2564 | Values: 1506.6 1512.9 1684.5 1820.7 1836.5 7916.9 8539.5 8582.4 9173.2 9179.2 8463.6 8604.4 8605.3 8697.1 8725.0 2318.8 2348.5 2356.1 2359.0 2365.4 2310.8 2314.7 2364.3 2366.3 2371.2 2302.2 2307.0 2317.4 2334.8 2345.0 2292.4 2301.7 2325.3 2326.9 2347.9 2274.7 2288.5 2289.0 2291.5 2292.3 8888.8 8965.9 8967.4 8968.2 8985.6 5257.9 5336.0 5384.5 5385.2 5388.3 3162.1 3196.1 3352.7 3412.2 3413.3 1080.1 1103.2 1119.7 1128.8 1140.4 12588.7 12803.2 12937.2 12941.3 12941.5 4659.7 4724.8 4828.5 4841.7 4853.5 10661.9 10665.1 10672.5 10682.5 10683.0 5416.1 5440.2 5447.4 5478.7 5489.9 4291.9 4820.0 4959.7 4971.8 5016.6 4081.0 4096.7 4130.1 4183.5 4189.0 1248.8 1264.3 1271.8 1281.7 1287.0 928.9 965.0 1023.9 1047.8 1059.1 6146.9 6312.8 6358.7 6371.0 6387.3 429.6 433.1 437.8 438.9 1006.2 4147.6 4225.2 4230.9 4261.9 4312.0 11067.7 11455.3 11473.8 11489.1 11514.6 10481.2 10815.8 10821.8 10843.9 11334.5 8132.6 8270.6 8282.5 8451.3 8459.2 6147.4 6266.2 6320.1 6347.0 6354.7 10266.4 10402.4 10480.5 10559.8 10582.7 10507.9 10605.8 10695.0 10729.1 10758.4 7408.1 8201.1 8544.1 8556.6 8725.3 8796.2 8815.9 8826.2 8840.6 8845.7 7855.4 8020.5 8035.4 8118.7 8126.3 7722.0 7859.6 7917.4 7991.6 8031.3 7147.9 7165.9 7199.3 7309.9 7318.1 5395.7 5402.3 5414.5 5437.0 5558.4 5258.7 5306.2 5371.6 5394.4 5411.3 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#4] prototype.html Cycles:180 Average:4748.39 Median:5354.91 stddev:1387.79 (25.9%) stddev-sans-first:1351.51 11:27:38 INFO - PROCESS | 2564 | Values: 331.3 335.4 338.0 339.4 342.0 5602.6 5679.2 5686.4 5700.0 5709.3 5632.7 5633.4 5652.9 5661.1 5663.1 4181.5 4234.3 4322.6 4349.6 4370.5 4345.0 4346.9 4351.0 4354.6 4387.7 4309.3 4323.6 4323.8 4332.8 4348.5 4204.0 4239.3 4334.0 4338.6 4343.2 3799.5 3818.8 3822.2 3827.9 3832.4 5357.2 5400.7 5411.5 5411.9 5497.9 4942.8 4949.9 4975.6 5003.5 5044.7 5744.5 5786.5 5793.7 5799.9 5858.4 4189.0 4239.8 4256.8 4259.5 4260.9 5758.6 6046.5 6066.5 6115.4 6129.9 4176.6 4195.3 4196.4 4204.6 4230.6 4220.5 4225.0 4249.5 4262.5 4263.3 4722.3 4825.4 4884.8 4911.6 4916.9 5831.9 5861.6 5872.4 5886.7 5958.8 1458.0 1464.6 1472.3 1476.9 1483.8 919.8 925.5 932.7 939.2 940.8 4990.8 4999.9 5013.9 5029.2 5094.8 5330.8 5352.6 5359.4 5381.5 5419.3 4848.0 4978.4 5079.8 5104.4 5114.7 2848.1 2866.0 2866.4 2886.5 2901.2 5592.8 5593.9 5610.4 5621.7 5625.7 5188.5 5515.4 5522.2 5526.6 5549.4 5559.4 5588.8 5595.2 5598.7 5607.5 5119.4 5266.9 5320.4 5408.3 5438.7 5265.6 5277.0 5277.9 5284.8 5292.6 5438.0 5442.8 5479.4 5482.9 5562.9 3807.0 3812.3 3861.9 3865.3 4208.2 5848.8 5878.3 6047.5 6051.4 6097.5 5896.8 5913.3 5951.9 5959.3 5963.1 5830.0 5871.4 5916.2 5918.9 5939.6 5631.0 5758.9 5776.6 5826.9 5831.4 5790.5 5905.6 5912.5 5922.4 5922.7 5575.4 5681.3 5785.6 5829.2 5842.2 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - PROCESS | 2564 | [#5] yui.html Cycles:180 Average:15590.24 Median:4659.46 stddev:18705.72 (401.5%) stddev-sans-first:18724.95 11:27:38 INFO - PROCESS | 2564 | Values: 737.8 772.4 776.6 781.5 784.8 14040.9 14578.5 15017.5 15160.6 15398.2 14057.4 14067.5 14073.2 14184.4 14201.7 685.3 802.6 810.5 823.1 825.9 821.5 822.3 823.3 823.5 824.8 851.6 852.9 853.4 853.6 855.1 848.9 849.8 850.0 850.2 852.6 612.4 617.6 618.1 619.0 620.8 14106.7 14118.1 14127.9 14180.2 14183.2 13463.5 13592.4 13676.5 13688.4 13951.4 11385.9 11513.9 11575.7 11577.6 11608.7 3781.9 3803.0 3811.2 3837.7 3954.5 57062.0 58032.4 58337.1 58377.4 58555.4 10340.6 10478.7 10551.1 10591.1 10762.4 19289.2 19308.8 19414.5 19422.7 19514.4 8168.5 8202.9 8265.4 8279.3 8299.2 4659.5 4659.5 4669.9 4670.9 4745.7 3303.9 3370.9 3402.3 3402.4 3418.4 620.2 626.1 632.8 640.0 655.7 642.6 691.0 772.4 773.2 792.6 9371.7 9418.3 9604.2 9658.8 9777.2 661.9 691.7 744.8 755.6 761.6 4316.4 4448.6 4472.8 4476.1 4515.5 66621.3 67073.7 67301.3 68077.0 68079.7 58812.0 60042.0 60087.4 60213.4 61622.1 52480.0 52900.7 53485.0 57176.0 57821.7 9221.7 9558.1 9575.8 9601.1 9672.9 36550.6 37173.8 37229.0 37516.8 38460.0 48257.5 51119.5 51129.0 51358.2 51419.0 11981.9 12386.8 12426.2 12787.7 13014.1 12364.7 13405.1 13564.8 13878.2 14343.1 11155.8 11302.3 11636.9 11675.4 11991.3 10929.5 11183.4 11849.9 12352.2 12430.5 11058.2 11957.3 12537.8 12770.1 13400.5 10237.6 10261.2 10412.1 10877.7 11315.5 11646.3 11692.6 11728.9 11776.1 11957.3 11:27:38 INFO - PROCESS | 2564 | -------- Summary: end -------- 11:27:38 INFO - PROCESS | 2564 | 11:27:38 INFO - TEST-INFO | 2564: exit 0 11:27:38 INFO - TEST-OK | dromaeo_css | took 1109910ms 11:27:38 INFO - TEST-START | kraken 11:27:38 INFO - operating with platform_type : linux_ 11:27:38 INFO - Initialising browser for kraken test... 11:27:38 INFO - TEST-INFO | started process 2893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSrupc/profile http://localhost:39607/getInfo.html) 11:27:43 INFO - PROCESS | 2893 | __metrics Screen width/height:1600/1200 11:27:43 INFO - PROCESS | 2893 | colorDepth:24 11:27:43 INFO - PROCESS | 2893 | Browser inner width/height: 1024/697 11:27:43 INFO - PROCESS | 2893 | __metrics 11:27:44 ERROR - PROCESS | 2893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:27:44 INFO - TEST-INFO | 2893: exit 0 11:27:44 INFO - Browser initialized. 11:27:44 INFO - Running cycle 1/1 for kraken test... 11:27:44 INFO - TEST-INFO | started process 3024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSrupc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:56 INFO - PROCESS | 3024 | RSS: Main: 167149568 11:27:56 INFO - PROCESS | 3024 | 11:27:59 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39607/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:00 INFO - PROCESS | 3024 | RSS: Main: 172601344 11:28:00 INFO - PROCESS | 3024 | 11:28:02 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39607/tests/kraken/driver.html?testName=audio-dft) 11:28:03 INFO - PROCESS | 3024 | RSS: Main: 171884544 11:28:03 INFO - PROCESS | 3024 | 11:28:06 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39607/tests/kraken/driver.html?testName=audio-fft) 11:28:06 INFO - PROCESS | 3024 | RSS: Main: 166526976 11:28:06 INFO - PROCESS | 3024 | 11:28:09 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39607/tests/kraken/driver.html?testName=audio-oscillator) 11:28:09 INFO - PROCESS | 3024 | RSS: Main: 167034880 11:28:09 INFO - PROCESS | 3024 | 11:28:11 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39607/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:12 INFO - PROCESS | 3024 | RSS: Main: 167661568 11:28:12 INFO - PROCESS | 3024 | 11:28:15 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39607/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:16 INFO - PROCESS | 3024 | RSS: Main: 167174144 11:28:16 INFO - PROCESS | 3024 | 11:28:19 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39607/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:20 INFO - PROCESS | 3024 | RSS: Main: 168513536 11:28:20 INFO - PROCESS | 3024 | 11:28:23 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39607/tests/kraken/driver.html?testName=json-parse-financial) 11:28:23 INFO - PROCESS | 3024 | RSS: Main: 168083456 11:28:23 INFO - PROCESS | 3024 | 11:28:25 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39607/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:25 INFO - PROCESS | 3024 | RSS: Main: 168181760 11:28:25 INFO - PROCESS | 3024 | 11:28:27 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:28 INFO - PROCESS | 3024 | RSS: Main: 168456192 11:28:28 INFO - PROCESS | 3024 | 11:28:30 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:31 INFO - PROCESS | 3024 | RSS: Main: 169009152 11:28:31 INFO - PROCESS | 3024 | 11:28:33 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:34 INFO - PROCESS | 3024 | RSS: Main: 168525824 11:28:34 INFO - PROCESS | 3024 | 11:28:37 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:37 INFO - PROCESS | 3024 | RSS: Main: 169017344 11:28:37 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:39607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39607/tests/kraken/driver.html?testName=ai-astar) 11:28:39 INFO - PROCESS | 3024 | RSS: Main: 169406464 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | __start_tp_report 11:28:39 INFO - PROCESS | 3024 | _x_x_mozilla_page_load 11:28:39 INFO - PROCESS | 3024 | _x_x_mozilla_page_load_details 11:28:39 INFO - PROCESS | 3024 | |i|pagename|runs| 11:28:39 INFO - PROCESS | 3024 | |0;ai-astar;113;108;113;113;113;111;111;114;110;111 11:28:39 INFO - PROCESS | 3024 | |1;audio-beat-detection;160;123;155;173;130;150;147;135;174;130 11:28:39 INFO - PROCESS | 3024 | |2;audio-dft;163;161;162;161;161;165;175;163;163;162 11:28:39 INFO - PROCESS | 3024 | |3;audio-fft;74;77;80;158;75;74;75;76;170;76 11:28:39 INFO - PROCESS | 3024 | |4;audio-oscillator;84;84;148;84;84;85;140;84;83;149 11:28:39 INFO - PROCESS | 3024 | |5;imaging-gaussian-blur;121;118;117;117;117;118;118;117;118;117 11:28:39 INFO - PROCESS | 3024 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;148;148 11:28:39 INFO - PROCESS | 3024 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 11:28:39 INFO - PROCESS | 3024 | |8;json-parse-financial;54;54;54;54;55;55;60;56;55;55 11:28:39 INFO - PROCESS | 3024 | |9;json-stringify-tinderbox;61;62;60;61;62;61;63;62;62;62 11:28:39 INFO - PROCESS | 3024 | |10;stanford-crypto-aes;81;82;81;79;84;81;82;81;113;80 11:28:39 INFO - PROCESS | 3024 | |11;stanford-crypto-ccm;131;121;122;128;127;137;125;132;128;134 11:28:39 INFO - PROCESS | 3024 | |12;stanford-crypto-pbkdf2;163;163;164;174;163;164;170;164;163;170 11:28:39 INFO - PROCESS | 3024 | |13;stanford-crypto-sha256-iterative;64;64;64;65;67;64;63;64;63;64 11:28:39 INFO - PROCESS | 3024 | __end_tp_report 11:28:39 INFO - PROCESS | 3024 | __start_cc_report 11:28:39 INFO - PROCESS | 3024 | _x_x_mozilla_cycle_collect,865 11:28:39 INFO - PROCESS | 3024 | __end_cc_report 11:28:39 INFO - PROCESS | 3024 | __startTimestamp1464805719579__endTimestamp 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | ------- Summary: start ------- 11:28:39 INFO - PROCESS | 3024 | Number of tests: 14 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:1.83 (1.6%) stddev-sans-first:1.88 11:28:39 INFO - PROCESS | 3024 | Values: 113.0 108.0 113.0 113.0 113.0 111.0 111.0 114.0 110.0 111.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:152.50 stddev:18.07 (11.9%) stddev-sans-first:18.61 11:28:39 INFO - PROCESS | 3024 | Values: 160.0 123.0 155.0 173.0 130.0 150.0 147.0 135.0 174.0 130.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:4.20 (2.6%) stddev-sans-first:4.44 11:28:39 INFO - PROCESS | 3024 | Values: 163.0 161.0 162.0 161.0 161.0 165.0 175.0 163.0 163.0 162.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:37.30 (49.4%) stddev-sans-first:38.89 11:28:39 INFO - PROCESS | 3024 | Values: 74.0 77.0 80.0 158.0 75.0 74.0 75.0 76.0 170.0 76.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.88 (35.6%) stddev-sans-first:30.94 11:28:39 INFO - PROCESS | 3024 | Values: 84.0 84.0 148.0 84.0 84.0 85.0 140.0 84.0 83.0 149.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:0.53 11:28:39 INFO - PROCESS | 3024 | Values: 121.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:28:39 INFO - PROCESS | 3024 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 148.0 148.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:28:39 INFO - PROCESS | 3024 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.81 (3.3%) stddev-sans-first:1.87 11:28:39 INFO - PROCESS | 3024 | Values: 54.0 54.0 54.0 54.0 55.0 55.0 60.0 56.0 55.0 55.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 11:28:39 INFO - PROCESS | 3024 | Values: 61.0 62.0 60.0 61.0 62.0 61.0 63.0 62.0 62.0 62.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.00 stddev:10.13 (12.5%) stddev-sans-first:10.67 11:28:39 INFO - PROCESS | 3024 | Values: 81.0 82.0 81.0 79.0 84.0 81.0 82.0 81.0 113.0 80.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.50 stddev:5.10 (3.9%) stddev-sans-first:5.33 11:28:39 INFO - PROCESS | 3024 | Values: 131.0 121.0 122.0 128.0 127.0 137.0 125.0 132.0 128.0 134.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:164.00 stddev:3.99 (2.4%) stddev-sans-first:4.11 11:28:39 INFO - PROCESS | 3024 | Values: 163.0 163.0 164.0 174.0 163.0 164.0 170.0 164.0 163.0 170.0 11:28:39 INFO - PROCESS | 3024 | 11:28:39 INFO - PROCESS | 3024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 11:28:39 INFO - PROCESS | 3024 | Values: 64.0 64.0 64.0 65.0 67.0 64.0 63.0 64.0 63.0 64.0 11:28:39 INFO - PROCESS | 3024 | -------- Summary: end -------- 11:28:39 INFO - PROCESS | 3024 | 11:28:40 INFO - TEST-INFO | 3024: exit 0 11:28:40 INFO - TEST-OK | kraken | took 61675ms 11:28:40 INFO - SUITE-END | took 1171s 11:28:40 INFO - Completed test suite (00:19:31) 11:28:40 INFO - javascript benchmark 11:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7177.635667394271, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.8920987765428, 3099.5970523831897, 3146.0247323329754, 3152.921176970575, 3161.620605527337, 5410.431904650014, 5417.972910135449, 5434.755436005385, 5480.972595137018, 5483.533899618537, 5253.474652534745, 5315.548178404831, 5418.8916221675545, 5457.263269458622, 5457.808976685817, 4891.217405215166, 4896.241082632188, 4930.161872481687, 4962.057209130254, 5046.949530504703, 510.27284385037166, 4926.679765815211, 5027.195648696209, 5044.596432285409, 5047.242913562958, 4786.688865223767, 4983.152864013126, 4991.151504244269, 4995.225740010304, 5043.924341134868, 4988.152014157602, 4999.125153098194, 5005.049040682259, 5020.246962955549, 5058.165402708549, 4871.244957031666, 4911.45973942866, 4916.729579873106, 4977.576905962997, 4987.226979818098, 5269.657472264329, 5336.653117547347, 5347.759350829222, 5361.115415956362, 5381.0852155133725, 5850.12248162779, 5881.088431293157, 5886.20536227608, 5888.823335299948, 5975.850603734898, 5632.746526406321, 5808.332041815203, 5848.41515848416, 5872.295324561037, 5906.527477801766, 5485.6982865942355, 5492.917606235909, 5493.642913210629, 5500.1749737539285, 5523.033469142884, 5779.595428320062, 5974.611650242808, 5990.520758339409, 5999.580029397987, 5999.940000599938, 5648.491635752802, 5651.6043876928225, 5763.538916886723, 5770.509506691894, 5786.681732504752, 5845.064789633639, 5941.58408911372, 5948.405159484017, 5954.791582294599, 5957.314908785545, 5816.272965879265, 5853.970730146322, 5923.111533270044, 5928.0, 5928.67392293428, 5841.123831425235, 5842.211301474332, 5851.707414629252, 5917.786853695068, 5955.13650520672, 4465.843695470643, 4466.062126953311, 4476.903158726068, 4491.124230775033, 4506.639468842484, 3891.591382904811, 3911.8630847920185, 3934.7442416243425, 3960.3663413853646, 3975.4036894465485, 5381.704006279692, 5533.22534845122, 5539.279893613804, 5581.190727344512, 5605.5515558755205, 5965.373635768268, 5965.522758179422, 5974.1934838796205, 5984.1921340618455, 5987.520998320124, 5364.222187782828, 5549.472800083986, 5596.384397716248, 5618.073017951992, 5625.943740562542, 5010.5240002199735, 5089.211172268304, 5093.2105523643895, 5100.4899510049445, 5130.9230361544605, 5733.512651424592, 6101.054336577838, 6125.96937015321, 6130.877382452326, 6136.386361363917, 5808.854778630568, 5840.912386314124, 5844.12338149281, 5897.203877476486, 5912.172295878494, 6044.486218671462, 6051.33435322123, 6055.727492262947, 6059.969700151471, 6063.120847477003, 5531.2532808072, 5743.971280143573, 5762.683052432157, 5763.193152958505, 5804.82585522435, 5924.229850119457, 6006.87986240264, 6008.819735407945, 6012.068129439944, 6063.757449702139, 5845.795397161079, 5847.649141051551, 5875.177475153397, 5877.588568800314, 5880.470757631833, 5536.141898005815, 5551.9722401387735, 5560.555155587463, 5821.126830975219, 5859.414058594277, 5430.647007944471, 5462.617616766788, 5490.533304669148, 5497.0, 5596.776128954796, 5606.803761868315, 5627.0, 5640.520555752642, 5654.660720356792, 5674.546036317167, 5428.511433970962, 5522.30971128609, 5572.080606700011, 5576.944230557642, 5616.85957851057], "value": 5354.121923978237, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2291928815387, 606.4451027310014, 617.5245061302797, 639.2648454277581, 664.3788058165619, 38820.0, 43259.35110973334, 43341.78329108358, 43424.0, 43510.782446087804, 35427.2914541709, 35510.0, 35647.2870542589, 35883.641163588356, 35934.64065359346, 8750.95624521878, 8953.865692014626, 8971.910280897206, 8972.192502674758, 8988.415752976069, 8800.779980500474, 8898.332625053115, 8901.73294801157, 8908.331875109361, 8915.108489151098, 8846.955765221164, 8908.0, 8916.554172291391, 8919.24186444153, 8921.95539022304, 8849.823003539957, 8861.202491775739, 8885.155910188554, 8903.287736981027, 8903.554822258926, 8833.381663283573, 8838.072002439716, 8905.154010369004, 8928.24109950655, 8946.68686595966, 33205.0, 41350.172996540205, 41773.582264177276, 41861.790691046655, 41882.0, 3373.325334932999, 3540.6813386795056, 3641.18073433478, 3691.778493290384, 3725.8509659613583, 31710.207244818834, 32028.519572206435, 32587.18532036694, 33512.29891228702, 34395.31209375799, 3895.4156876468473, 3903.0, 4018.1561872006623, 4079.77561234132, 4155.10665206982, 137638.0, 138867.0, 139126.0, 139312.30343848217, 139358.0, 65226.0, 65751.67124164349, 65877.0, 66011.66994164999, 66101.66949165224, 70338.64830675814, 70710.2928970714, 70878.64560677164, 71080.2891971084, 71122.64438677774, 16222.756658650129, 17152.742708859376, 17467.82532174662, 17489.91255043742, 17561.912190438965, 13396.732065358834, 13541.458341666223, 13585.116967397285, 13594.32028398576, 13624.591262261949, 20275.493112672302, 20342.288019919233, 20771.169153234005, 20800.271990480564, 20803.58392832135, 7323.377512911356, 7501.924980750232, 7641.923580764233, 7677.347425468786, 7702.229777022253, 943.4009404028492, 1032.7056788815153, 1069.1660504806264, 1117.7317443813427, 1151.8329842172839, 33199.83400082984, 33564.664353356646, 33695.326093478485, 33936.11543018871, 33981.490277645855, 1165.4813607944552, 1178.3106882473678, 1187.5427960235372, 1245.6263121063826, 1260.1619922751267, 16966.91516542434, 17624.471265862045, 17706.734398984026, 17713.743284412747, 17756.28974840992, 521366.0, 522569.0, 524135.0, 527150.0, 528495.0, 60367.0, 61304.0, 61314.0, 61369.38630613726, 61559.38440615626, 1325.3174615073244, 1368.1244003837553, 1368.5210176438168, 1398.9230592317317, 1400.5308221745624, 31747.0, 32876.34247315088, 33054.338913222084, 33219.0, 33325.16687082842, 53007.469925300255, 53161.67095822635, 53350.73324633352, 53379.73310133425, 53418.0, 454695.0, 456287.0, 456545.0, 458314.0, 458907.0, 44195.33706994462, 44681.32978005268, 45662.77168614136, 45690.54309456863, 45916.54083459123, 48775.756121220584, 49326.50673493219, 49718.50281497283, 50530.0, 50582.24126638177, 38618.6138138615, 39179.41230881596, 39697.0, 39725.40411893766, 39864.402033970095, 42250.577494224664, 42518.574814251464, 42606.36090458584, 42614.78692606641, 42937.0, 42131.0, 42361.0, 43249.78375108104, 43275.567244327154, 43532.56467435285, 35459.29081418409, 38211.80894095512, 38215.0, 38541.42187867128, 38792.41811372888, 29125.271868202617, 29289.560656589743, 29515.262118446353, 29554.078984865915, 29627.703722962495], "value": 20278.403448690162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1495278147776, 383.18381846666597, 394.9723519353645, 400.96190861868115, 407.8592885454517, 16807.83192168078, 19377.418677439666, 19647.115879785408, 19788.802111978875, 19834.90082549589, 18858.71711924322, 19222.13500392482, 19222.231110755554, 19264.22943082275, 19583.902080489614, 5488.615796894199, 5630.831075067745, 5727.770889164429, 5782.3350314713925, 5850.502707269887, 5649.519790817785, 5716.28546431696, 5726.713664316789, 5744.856378590548, 5759.4816466518005, 5493.23094766733, 5667.4615911488345, 5699.202111704344, 5732.2261494698305, 5738.8278351649515, 5696.743646535916, 5700.515456186229, 5708.257926469574, 5732.48407643312, 5744.569157313197, 4959.0, 5072.898542029176, 5082.110630639623, 5082.263071854597, 5110.003549307887, 20443.79556204434, 21664.458388540414, 21789.782102178935, 21905.0, 22507.32478025662, 2125.171183238538, 2261.118163916074, 2324.4886125052462, 2522.2433270019105, 2732.180345896223, 10049.34679245854, 10185.643502477451, 10565.841512377321, 10572.78854422915, 10748.838767418494, 1873.8313551780268, 1924.6824273994773, 2036.4297996560986, 2051.1795281887216, 2056.958860822775, 79160.0, 79267.20732792656, 80013.59993199997, 80322.19677803264, 80723.19276807274, 10719.946400268105, 10876.782464350668, 10884.129269658408, 11034.062104721188, 11222.887771122347, 15250.161241131622, 15441.613959650875, 15497.380104795908, 15509.922450387676, 15537.766933496006, 7907.604619768988, 8148.22591853773, 8311.127331630092, 8319.126491718282, 8394.87407688873, 7938.5236885787035, 8095.473794203475, 8125.1062383137805, 8215.712450064219, 8218.506889586644, 4689.249720044844, 4709.152352576501, 4721.220998535272, 4726.95273047272, 4859.319695242669, 1953.9218431262875, 1994.7107669388147, 1997.460685614876, 2000.6398848207461, 2039.7450318710162, 875.382855087162, 1008.2538921198407, 1026.2662196529518, 1048.6749107776614, 1113.7414721364805, 18768.249270029046, 19157.425277241706, 19388.806111938982, 19467.415977520697, 19896.0, 1004.6182450668699, 1015.7155996321042, 1022.5602990713916, 1037.4242295526055, 1126.189143816451, 10730.141588672888, 10874.46333334982, 10921.617743379102, 11014.724631884106, 11034.558617655204, 492325.0, 502099.0, 502278.0, 504547.0, 510983.0, 60483.0, 74540.62729686317, 95278.0, 95453.0, 99774.0, 996.0935548650693, 1022.4632068164422, 1027.753339198602, 1045.5660900726266, 1064.9414282214552, 17459.82540174582, 17857.642847143245, 18086.5478363042, 18173.0, 18552.721709174104, 29008.12975610735, 36072.639273606925, 40732.79633601813, 40985.795071024455, 41336.37995430131, 51638.0, 52774.47225527695, 53615.19577206267, 59970.0, 62280.68859655673, 7972.92027079745, 8348.958255208685, 8408.87386689188, 8534.317254619491, 8610.655573777229, 9529.714108576754, 12689.428975695932, 12906.096573239784, 12954.417051232529, 13210.734650806722, 11606.361650108987, 11700.239484433485, 11722.58970936013, 11785.587504437304, 11879.0, 5193.61047921415, 10775.461226938778, 10993.0, 11177.776444470903, 11290.491927863102, 11157.49791259379, 11221.877812218712, 11495.482703278205, 11648.76702465929, 11710.590129345432, 8383.580820958805, 8537.615807288563, 8571.871421928801, 8583.957080214559, 8812.91187088121, 8467.068622451648, 11193.048590869541, 11427.485763140845, 11571.942140289244, 11781.705457363634], "value": 9102.202868220122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.5630967019565, 1512.9319180636871, 1684.5367523930918, 1820.6904826179539, 1836.5316844204726, 7916.881246781303, 8539.48763074216, 8582.356323275755, 9173.220276276516, 9179.173874351307, 8463.576821158933, 8604.39769216155, 8605.268552173056, 8697.1302869713, 8724.956375218115, 2318.849274797137, 2348.471593891369, 2356.1046802215133, 2359.0210062823908, 2365.373176108324, 2310.849794763343, 2314.6990891184123, 2364.3143488388346, 2366.2546297916188, 2371.158238825218, 2302.1712183613886, 2307.0310469602805, 2317.385892738426, 2334.7898689117974, 2345.0, 2292.449812045097, 2301.6892719482908, 2325.348902307348, 2326.8603883766946, 2347.929562113139, 2274.6701728249313, 2288.485090854561, 2288.9885550572308, 2291.4958709083976, 2292.32376448948, 8888.822223555493, 8965.910340896573, 8967.372283940127, 8968.237699795525, 8985.595648195847, 5257.86855328616, 5336.039512887679, 5384.461553844623, 5385.246065550826, 5388.326459192601, 3162.114607909789, 3196.0891146023505, 3352.664733526628, 3412.2493051528622, 3413.2661477782394, 1080.1304949515636, 1103.167108832826, 1119.6696974392573, 1128.841962125303, 1140.3727949627755, 12588.68528286791, 12803.167794093353, 12937.159084659466, 12941.288229147392, 12941.48234070636, 4659.743714095757, 4724.834630787906, 4828.46886842447, 4841.709497430165, 4853.466118726938, 10661.893381066246, 10665.093467055232, 10672.519736611872, 10682.51928663212, 10683.038526532493, 5416.052190866582, 5440.156775699694, 5447.428020057916, 5478.726063696799, 5489.862753431196, 4291.892702682458, 4819.975900120477, 4959.70241785494, 4971.801127954841, 5016.648834581617, 4081.0288374294587, 4096.730013695764, 4130.070734084807, 4183.456150700389, 4188.973701443166, 1248.7502499500135, 1264.2983144354787, 1271.8155867399175, 1281.6795801049739, 1287.0411543400228, 928.893177284621, 964.9662261820943, 1023.8771347438355, 1047.7747284333905, 1059.0838924330399, 6146.877062458726, 6312.779052733133, 6358.745650173942, 6371.012493063583, 6387.265464471645, 429.5875959079256, 433.1358938916881, 437.7767338657244, 438.8639521748268, 1006.2453160129902, 4147.585241475888, 4225.154969006211, 4230.915381692349, 4261.850835220753, 4312.0, 11067.72330691723, 11455.255408398427, 11473.827892581618, 11489.138314626436, 11514.596989105341, 10481.161507079416, 10815.78368432627, 10821.783564328669, 10843.891561084445, 11334.489947952361, 8132.5933703314595, 8270.627821748036, 8282.544460054634, 8451.323894088458, 8459.154084591615, 6147.415995480422, 6266.185395898504, 6320.083587879823, 6347.016212487072, 6354.650494222862, 10266.395079479, 10402.427866467417, 10480.475976201313, 10559.788804224027, 10582.682519524427, 10507.894921050998, 10605.840912386166, 10694.983976522219, 10729.141668666332, 10758.40828754426, 7408.148062972827, 8201.13888041771, 8544.102869198645, 8556.57217139153, 8725.25835303981, 8796.164364385373, 8815.911840881508, 8826.24976876947, 8840.55797210124, 8845.690400836198, 7855.410844186823, 8020.516204501952, 8035.397345199017, 8118.715844945398, 8126.309263712415, 7721.961390193013, 7859.567723775019, 7917.445778795429, 7991.64037618297, 8031.277185053374, 7147.892781608384, 7165.928340716735, 7199.280071992759, 7309.926900730925, 7318.085239345082, 5395.730213489388, 5402.270693456333, 5414.539764120094, 5437.02133615953, 5558.3607885092115, 5258.737063146751, 5306.177542480922, 5371.579136475226, 5394.433584473731, 5411.2965314508865], "value": 4686.54475206582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2844256406162, 335.4280950978582, 337.9831008449577, 339.441618537506, 342.0, 5602.551795856332, 5679.182661548306, 5686.402927692595, 5700.0, 5709.286339207599, 5632.746526406311, 5633.352164501083, 5652.886942261152, 5661.094224924013, 5663.122216056508, 4181.519125300599, 4234.280172370704, 4322.567743225683, 4349.630281426067, 4370.4755429348525, 4345.0, 4346.8913277168, 4350.956490435103, 4354.608085272325, 4387.670924680646, 4309.332053531708, 4323.610875021247, 4323.848665296715, 4332.84835030774, 4348.543402942693, 4203.958369730689, 4239.258129827268, 4333.978330108361, 4338.631216346615, 4343.174796788631, 3799.525059367579, 3818.8281527331337, 3822.2164456286396, 3827.942580861289, 3832.3868181090893, 5357.223202635596, 5400.675959442446, 5411.540019098381, 5411.864703382447, 5497.862553436196, 4942.811886333295, 4949.925751113737, 4975.552200301954, 5003.499650034967, 5044.672096313728, 5744.511716504102, 5786.46658635462, 5793.652380857162, 5799.884002319972, 5858.443447872488, 4188.979055104735, 4239.788010599457, 4256.808443620044, 4259.51015633203, 4260.850870219559, 5758.62568933018, 6046.516278697738, 6066.4540191382985, 6115.388461153893, 6129.908051379233, 4176.644985176234, 4195.307774217281, 4196.426340122454, 4204.642605378577, 4230.5769423057445, 4220.451341325669, 4224.957750422518, 4249.511306199826, 4262.509811371732, 4263.317869140985, 4722.315264286659, 4825.420949486084, 4884.778805298675, 4911.63162762787, 4916.852494425173, 5831.883362332815, 5861.648301101947, 5872.35913733488, 5886.70418536771, 5958.821235362946, 1457.9575603443589, 1464.6045567696663, 1472.271225743264, 1476.9409223631149, 1483.7848511965703, 919.8206349761866, 925.5372313843078, 932.6689025395887, 939.1641439119189, 940.7789169545151, 4990.750462476862, 4999.850004499871, 5013.874653133701, 5029.245613158056, 5094.821681241138, 5330.786768529216, 5352.598555108382, 5359.410464848864, 5381.470708766873, 5419.268398766195, 4847.975760121177, 4978.386347167693, 5079.771410286546, 5104.387473503203, 5114.693118412907, 2848.091778508363, 2865.9713402866123, 2866.426714657077, 2886.5381538953666, 2901.2166714986834, 5592.769590690042, 5593.916091258634, 5610.382857885629, 5621.7189140542805, 5625.718714064362, 5188.481151884781, 5515.448455154453, 5522.171674248814, 5526.613137080446, 5549.361823390362, 5559.416261292587, 5588.804391846266, 5595.188697638901, 5598.748056337393, 5607.467290607386, 5119.385673719029, 5266.920996184984, 5320.361556613077, 5408.296921400193, 5438.721900353493, 5265.552428043659, 5276.973615131899, 5277.894442111213, 5284.762185701729, 5292.576593872558, 5437.972810135924, 5442.755076021509, 5479.369872464558, 5482.917756233739, 5562.944370556243, 3807.010177353963, 3812.3328417527377, 3861.864834730771, 3865.2849222893856, 4208.200441916026, 5848.766049358148, 5878.29460464747, 6047.5464340173785, 6051.394860513913, 6097.542684298606, 5896.7936122235515, 5913.34953155144, 5951.851203719942, 5959.284885813557, 5963.135345374983, 5829.970850145722, 5871.354151043296, 5916.230889984275, 5918.852028699317, 5939.643621382558, 5631.0, 5758.942410576008, 5776.624519406393, 5826.941730582809, 5831.4168583141345, 5790.494471437372, 5905.586608937333, 5912.526997840077, 5922.378150294157, 5922.703864806828, 5575.4424557543925, 5681.261436013292, 5785.553611597101, 5829.163813398766, 5842.1820945068575], "value": 4303.4401476780495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.8413641067169, 772.4416583728221, 776.6272189349112, 781.5037451218478, 784.7841843493043, 14040.929795351021, 14578.489752858652, 15017.549473515784, 15160.62098447538, 15398.153101579408, 14057.367418466194, 14067.507637232698, 14073.155610663342, 14184.43262269508, 14201.715965680705, 685.3454950522264, 802.6067227058728, 810.4934415990007, 823.0575990490885, 825.8637324841394, 821.4660470694067, 822.3092602214139, 823.3454403749034, 823.4647479138578, 824.8391563645091, 851.6040041380757, 852.8720691896203, 853.4154104438479, 853.6372041882175, 855.1320409784043, 848.9151084891523, 849.7790574450626, 850.0394554153797, 850.230541360064, 852.6461518469828, 612.4120843989775, 617.5831313863124, 618.0821480102045, 618.9628622282632, 620.751699320271, 14106.71786564263, 14118.082324648865, 14127.858721412756, 14180.22008789516, 14183.219922904236, 13463.461461541625, 13592.38834252461, 13676.521321753691, 13688.384022719001, 13951.372188251553, 11385.886141138566, 11513.884861151366, 11575.710607234802, 11577.594784182598, 11608.709782255426, 3781.9054523636855, 3802.9619703802887, 3811.1996480739076, 3837.6546110849877, 3954.5452272988687, 57062.0, 58032.419675803125, 58337.124943125884, 58377.416225838046, 58555.41444585542, 10340.586376545005, 10478.685639430829, 10551.103156231653, 10591.060746943236, 10762.3542587445, 19289.228430862888, 19308.80691193098, 19414.514637134183, 19422.70865937012, 19514.414567562995, 8168.469049511763, 8202.876956845652, 8265.380096492787, 8279.254867061993, 8299.211574900375, 4659.464161621389, 4659.464161621389, 4669.883252918704, 4670.929936050962, 4745.715257084586, 3303.8513266903046, 3370.898873033813, 3402.3365443738235, 3402.438597631363, 3418.3505134024954, 620.203039094761, 626.1077963901422, 632.8354627796806, 640.0495264532166, 655.7147640776277, 642.601587016053, 690.9670043285321, 772.4052479590796, 773.1649818196335, 792.6036981509245, 9371.718848434557, 9418.29362797793, 9604.183644390305, 9658.806823863484, 9777.168940640126, 661.927677162999, 691.7267679266662, 744.780289814506, 755.6033082631662, 761.5544906229807, 4316.417283666665, 4448.5551444855255, 4472.776361181993, 4476.149531588988, 4515.503294637587, 66621.33378666152, 67073.6646316775, 67301.3269867295, 68077.0, 68079.65960170167, 58812.0, 60042.0, 60087.399126009055, 60213.39786602078, 61622.075668865, 52480.0, 52900.735496322275, 53485.0, 57176.0, 57821.71089144528, 9221.677241296522, 9558.091981261769, 9575.808483830424, 9601.135897769234, 9672.854907176257, 36550.634493654725, 37173.814130929175, 37229.0, 37516.81241593775, 38460.0, 48257.5174248253, 51119.488805111476, 51129.0, 51358.22962655489, 51419.0, 11981.940090299493, 12386.81419778686, 12426.192297500633, 12787.680307992374, 13014.089013768946, 12364.690882727644, 13405.128666636638, 13564.79652805189, 13878.16730996103, 14343.067700599428, 11155.776884462428, 11302.321860688386, 11636.94181529087, 11675.416229188337, 11991.340476273888, 10929.508172132115, 11183.384913829492, 11849.940750296193, 12352.197107188003, 12430.502779888704, 11058.170637202082, 11957.282563046245, 12537.789177478542, 12770.106092573431, 13400.530981415994, 10237.616505383408, 10261.17910567138, 10412.114970227616, 10877.67366978992, 11315.490802913724, 11646.301221926711, 11692.590759323382, 11728.94135529317, 11776.097243670423, 11957.342346171044], "value": 6859.734519742678, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 113.0, 113.0, 111.0, 111.0, 114.0, 110.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 155.0, 173.0, 130.0, 150.0, 147.0, 135.0, 174.0, 130.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 165.0, 175.0, 163.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 80.0, 158.0, 75.0, 74.0, 75.0, 76.0, 170.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 84.0, 84.0, 85.0, 140.0, 84.0, 83.0, 149.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 60.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 79.0, 84.0, 81.0, 82.0, 81.0, 113.0, 80.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 122.0, 128.0, 127.0, 137.0, 125.0, 132.0, 128.0, 134.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 174.0, 163.0, 164.0, 170.0, 164.0, 163.0, 170.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 67.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 64.2, "unit": "score"}]}]} 11:28:40 INFO - Return code: 0 11:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:28:40 ERROR - # TBPL SUCCESS # 11:28:40 INFO - Running post-action listener: _resource_record_post_action 11:28:40 INFO - ##### 11:28:40 INFO - ##### Finished run-tests step (success) 11:28:40 INFO - ##### 11:28:40 INFO - Running post-run listener: _resource_record_post_run 11:28:40 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 4096; Write bytes: 541085696; Read time: 12; Write time: 385516 11:28:40 INFO - TinderboxPrint: CPU usage
13.5% 11:28:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:28:40 INFO - TinderboxPrint: I/O write bytes / time
541,085,696 / 385,516 11:28:40 INFO - TinderboxPrint: CPU idle
8,208.5 (86.4%) 11:28:40 INFO - TinderboxPrint: CPU user
1,230.0 (13.0%) 11:28:40 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247554048; Read time: 0; Write time: 191676 11:28:40 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 4096; Write bytes: 293355520; Read time: 12; Write time: 193820 11:28:41 INFO - Running post-run listener: _upload_blobber_files 11:28:41 INFO - Blob upload gear active. 11:28:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:41 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 11:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:42 INFO - (blobuploader) - INFO - Done attempting. 11:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:43 INFO - (blobuploader) - INFO - Done attempting. 11:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:47 INFO - (blobuploader) - INFO - Done attempting. 11:28:47 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:47 INFO - Return code: 0 11:28:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5e370e22f998162bcba75c6b0a3b7a049c3b3d4456822dcf01db9424236b816aa73d145b0929505836f75f19c92ecd558b89d5bbcac73957d80881c8959599c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bae8c3a9bd89eee08329af6295ee1fdfa4624ab51fa61e70d077197cadc4c08b1ed63435010655960631b89caa8bb9882ca15d2c6267d3a8a481630b3cdfcad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62e7797190196eff3063ee6b4b281f5e33c83cbc9cd6b062820876110d4666b983433828efc7da4aa481bda424aad19581da40d767a07ba7a9d0820fdbe66217"} 11:28:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:47 INFO - Contents: 11:28:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5e370e22f998162bcba75c6b0a3b7a049c3b3d4456822dcf01db9424236b816aa73d145b0929505836f75f19c92ecd558b89d5bbcac73957d80881c8959599c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bae8c3a9bd89eee08329af6295ee1fdfa4624ab51fa61e70d077197cadc4c08b1ed63435010655960631b89caa8bb9882ca15d2c6267d3a8a481630b3cdfcad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62e7797190196eff3063ee6b4b281f5e33c83cbc9cd6b062820876110d4666b983433828efc7da4aa481bda424aad19581da40d767a07ba7a9d0820fdbe66217"} 11:28:47 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:47 INFO - Copying logs to upload dir... 11:28:47 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.777498 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-01 11:28:47.262099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 11:28:47.265930) ========= 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-1464803122.897397-1642509559 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/sha512/e5e370e22f998162bcba75c6b0a3b7a049c3b3d4456822dcf01db9424236b816aa73d145b0929505836f75f19c92ecd558b89d5bbcac73957d80881c8959599c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bae8c3a9bd89eee08329af6295ee1fdfa4624ab51fa61e70d077197cadc4c08b1ed63435010655960631b89caa8bb9882ca15d2c6267d3a8a481630b3cdfcad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62e7797190196eff3063ee6b4b281f5e33c83cbc9cd6b062820876110d4666b983433828efc7da4aa481bda424aad19581da40d767a07ba7a9d0820fdbe66217"} build_url:https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/SRGMKyldSAq0-k9gYaWXSw/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/sha512/e5e370e22f998162bcba75c6b0a3b7a049c3b3d4456822dcf01db9424236b816aa73d145b0929505836f75f19c92ecd558b89d5bbcac73957d80881c8959599c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bae8c3a9bd89eee08329af6295ee1fdfa4624ab51fa61e70d077197cadc4c08b1ed63435010655960631b89caa8bb9882ca15d2c6267d3a8a481630b3cdfcad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62e7797190196eff3063ee6b4b281f5e33c83cbc9cd6b062820876110d4666b983433828efc7da4aa481bda424aad19581da40d767a07ba7a9d0820fdbe66217"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 11:28:47.290913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:28:47.291226) ========= 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-1464803122.897397-1642509559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004734 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 11:28:47.372228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 11:28:47.372556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 11:28:47.372851) ========= ========= Total master_lag: 0.19 =========