builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1464266347.7 results: success (0) buildid: 20160526030223 builduid: aa5bc1d9d7dc469dbb5d15e82ff7ba90 revision: 8d0aadfe7da782d415363880008b4ca027686137 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.702351) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.705275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.705823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.797035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.797287) ========= 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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 05:39: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% 46.6M=0s 2016-05-26 05:39:08 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.986580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:07.990074) ========= 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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017507 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.047657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.048184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d0aadfe7da782d415363880008b4ca027686137 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8d0aadfe7da782d415363880008b4ca027686137 --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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 05:39:08,128 truncating revision to first 12 chars 2016-05-26 05:39:08,128 Setting DEBUG logging. 2016-05-26 05:39:08,128 attempt 1/10 2016-05-26 05:39:08,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d0aadfe7da7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 05:39:08,445 unpacking tar archive at: mozilla-central-8d0aadfe7da7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.933513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.933828) ========= script_repo_revision: 8d0aadfe7da782d415363880008b4ca027686137 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.936571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.936857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:39:08.946781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-26 05:39:08.947050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:09 INFO - MultiFileLogger online at 20160526 05:39:09 in /builds/slave/test 05:39:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:09 INFO - {'append_to_log': False, 05:39:09 INFO - 'base_work_dir': '/builds/slave/test', 05:39:09 INFO - 'blob_upload_branch': 'Firefox', 05:39:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:09 INFO - 'branch': 'Firefox', 05:39:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:09 INFO - 'config_files': ('talos/linux_config.py',), 05:39:09 INFO - 'default_actions': ('clobber', 05:39:09 INFO - 'read-buildbot-config', 05:39:09 INFO - 'download-and-extract', 05:39:09 INFO - 'populate-webroot', 05:39:09 INFO - 'create-virtualenv', 05:39:09 INFO - 'install', 05:39:09 INFO - 'run-tests'), 05:39:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:09 INFO - 'download_minidump_stackwalk': True, 05:39:09 INFO - 'download_symbols': 'ondemand', 05:39:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:09 INFO - 'installer_path': 'installer.exe', 05:39:09 INFO - 'log_level': 'info', 05:39:09 INFO - 'log_name': 'talos', 05:39:09 INFO - 'log_to_console': True, 05:39:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:09 INFO - 'opt_config_files': (), 05:39:09 INFO - 'pip_index': False, 05:39:09 INFO - 'sps_profile': False, 05:39:09 INFO - 'sps_profile_interval': 0, 05:39:09 INFO - 'suite': 'dromaeojs-e10s', 05:39:09 INFO - 'system_bits': '32', 05:39:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:09 INFO - 'title': 'talos-linux64-ix-058', 05:39:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:09 INFO - 'use_talos_json': True, 05:39:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:09 INFO - 'work_dir': 'build'} 05:39:09 INFO - ##### 05:39:09 INFO - ##### Running clobber step. 05:39:09 INFO - ##### 05:39:09 INFO - Running pre-action listener: _resource_record_pre_action 05:39:09 INFO - Running main action method: clobber 05:39:09 INFO - rmtree: /builds/slave/test/build 05:39:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:09 INFO - Running post-action listener: _resource_record_post_action 05:39:09 INFO - ##### 05:39:09 INFO - ##### Finished clobber step (success) 05:39:09 INFO - ##### 05:39:09 INFO - ##### 05:39:09 INFO - ##### Running read-buildbot-config step. 05:39:09 INFO - ##### 05:39:09 INFO - Running pre-action listener: _resource_record_pre_action 05:39:09 INFO - Running main action method: read_buildbot_config 05:39:09 INFO - Using buildbot properties: 05:39:09 INFO - { 05:39:09 INFO - "project": "", 05:39:09 INFO - "product": "firefox", 05:39:09 INFO - "script_repo_revision": "production", 05:39:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:09 INFO - "repository": "", 05:39:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:09 INFO - "buildid": "20160526030223", 05:39:09 INFO - "stage_platform": "linux64-pgo", 05:39:09 INFO - "basedir": "/builds/slave/test", 05:39:09 INFO - "nightly_build": "True", 05:39:09 INFO - "buildnumber": 738, 05:39:09 INFO - "slavename": "talos-linux64-ix-058", 05:39:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:39:09 INFO - "platform": "ubuntu64_hw", 05:39:09 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:09 INFO - "branch": "mozilla-central", 05:39:09 INFO - "repo_path": "mozilla-central", 05:39:09 INFO - "revision": "8d0aadfe7da782d415363880008b4ca027686137", 05:39:09 INFO - "pgo_build": "True", 05:39:09 INFO - "builduid": "aa5bc1d9d7dc469dbb5d15e82ff7ba90", 05:39:09 INFO - "slavebuilddir": "test" 05:39:09 INFO - } 05:39:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:39:09 INFO - Running post-action listener: _resource_record_post_action 05:39:09 INFO - ##### 05:39:09 INFO - ##### Finished read-buildbot-config step (success) 05:39:09 INFO - ##### 05:39:09 INFO - ##### 05:39:09 INFO - ##### Running download-and-extract step. 05:39:09 INFO - ##### 05:39:09 INFO - Running pre-action listener: _resource_record_pre_action 05:39:09 INFO - Running main action method: download_and_extract 05:39:09 INFO - mkdir: /builds/slave/test/build/tests 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:09 INFO - https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:17 INFO - Downloaded 1361 bytes. 05:39:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:39:17 INFO - Using the following test package requirements: 05:39:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'jsshell-linux-x86_64.zip'], 05:39:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:17 INFO - https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:19 INFO - Downloaded 24408456 bytes. 05:39:19 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'] 05:39:19 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 05:39:20 INFO - Return code: 0 05:39:20 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 05:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:20 INFO - https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:27 INFO - Downloaded 24408456 bytes. 05:39:27 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'] 05:39:27 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 05:39:28 INFO - Return code: 0 05:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:28 INFO - https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:30 INFO - Downloaded 10834034 bytes. 05:39:30 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'] 05:39:30 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 05:39:30 INFO - Return code: 0 05:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:30 INFO - https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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 05:39:32 INFO - Downloaded 58662756 bytes. 05:39:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:32 INFO - mkdir: /builds/slave/test/properties 05:39:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:32 INFO - Contents: 05:39:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:39:33 INFO - Running post-action listener: _resource_record_post_action 05:39:33 INFO - Running post-action listener: set_extra_try_arguments 05:39:33 INFO - ##### 05:39:33 INFO - ##### Finished download-and-extract step (success) 05:39:33 INFO - ##### 05:39:33 INFO - ##### 05:39:33 INFO - ##### Running populate-webroot step. 05:39:33 INFO - ##### 05:39:33 INFO - Running pre-action listener: _resource_record_pre_action 05:39:33 INFO - Running main action method: populate_webroot 05:39:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:33 INFO - '--tppagecycles', 05:39:33 INFO - '7'], 05:39:33 INFO - 'tests': ['tsvgm']}}, 05:39:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['damp', 'tps']}, 05:39:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'tests': ['damp', 'tps']}, 05:39:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['dromaeo_dom']}, 05:39:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['a11yr', 05:39:33 INFO - 'ts_paint', 05:39:33 INFO - 'tpaint', 05:39:33 INFO - 'sessionrestore', 05:39:33 INFO - 'sessionrestore_no_auto_restore', 05:39:33 INFO - 'tabpaint']}, 05:39:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['tsvgx', 05:39:33 INFO - 'tsvgr_opacity', 05:39:33 INFO - 'tart', 05:39:33 INFO - 'tscrollx', 05:39:33 INFO - 'cart']}, 05:39:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:33 INFO - 'tsvgr_opacity', 05:39:33 INFO - 'tart', 05:39:33 INFO - 'tscrollx', 05:39:33 INFO - 'cart']}, 05:39:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'talos_options': ['--disable-e10s'], 05:39:33 INFO - 'tests': ['tp5o']}, 05:39:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'tests': ['tp5o']}, 05:39:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'talos_options': ['--disable-e10s', 05:39:33 INFO - '--xperf_path', 05:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:33 INFO - 'tests': ['tp5n']}, 05:39:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:33 INFO - 'talos_options': ['--xperf_path', 05:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:33 INFO - 'tests': ['tp5n']}}, 05:39:33 INFO - 'talos.zip': {'path': '', 05:39:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:33 INFO - Running post-action listener: _resource_record_post_action 05:39:33 INFO - ##### 05:39:33 INFO - ##### Finished populate-webroot step (success) 05:39:33 INFO - ##### 05:39:33 INFO - ##### 05:39:33 INFO - ##### Running create-virtualenv step. 05:39:33 INFO - ##### 05:39:33 INFO - Running pre-action listener: _resource_record_pre_action 05:39:33 INFO - Running main action method: create_virtualenv 05:39:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:33 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 05:39:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:33 INFO - Using real prefix '/usr' 05:39:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:35 INFO - Installing pip.................done. 05:39:35 INFO - Return code: 0 05:39:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:35 INFO - Using env: {'DISPLAY': ':0', 05:39:35 INFO - 'HOME': '/home/cltbld', 05:39:35 INFO - 'LANG': 'en_US.UTF-8', 05:39:35 INFO - 'LANGUAGE': 'en_US:en', 05:39:35 INFO - 'LOGNAME': 'cltbld', 05:39:35 INFO - 'MAIL': '/var/mail/cltbld', 05:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:35 INFO - 'MOZ_NO_REMOTE': '1', 05:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:35 INFO - 'NO_EM_RESTART': '1', 05:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:35 INFO - 'PWD': '/builds/slave/test', 05:39:35 INFO - 'SHELL': '/bin/bash', 05:39:35 INFO - 'SHLVL': '1', 05:39:35 INFO - 'TERM': 'linux', 05:39:35 INFO - 'TMOUT': '86400', 05:39:35 INFO - 'USER': 'cltbld', 05:39:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:35 INFO - '_': '/tools/buildbot/bin/python'} 05:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:35 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 05:39:35 INFO - Cleaning up... 05:39:35 INFO - Return code: 0 05:39:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:35 INFO - Using env: {'DISPLAY': ':0', 05:39:35 INFO - 'HOME': '/home/cltbld', 05:39:35 INFO - 'LANG': 'en_US.UTF-8', 05:39:35 INFO - 'LANGUAGE': 'en_US:en', 05:39:35 INFO - 'LOGNAME': 'cltbld', 05:39:35 INFO - 'MAIL': '/var/mail/cltbld', 05:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:35 INFO - 'MOZ_NO_REMOTE': '1', 05:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:35 INFO - 'NO_EM_RESTART': '1', 05:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:35 INFO - 'PWD': '/builds/slave/test', 05:39:35 INFO - 'SHELL': '/bin/bash', 05:39:35 INFO - 'SHLVL': '1', 05:39:35 INFO - 'TERM': 'linux', 05:39:35 INFO - 'TMOUT': '86400', 05:39:35 INFO - 'USER': 'cltbld', 05:39:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:35 INFO - '_': '/tools/buildbot/bin/python'} 05:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:36 INFO - Downloading/unpacking psutil>=3.1.1 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:38 INFO - Installing collected packages: psutil 05:39:38 INFO - Running setup.py install for psutil 05:39:38 INFO - building 'psutil._psutil_linux' extension 05:39:38 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 05:39:38 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 05:39:38 INFO - building 'psutil._psutil_posix' extension 05:39:38 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 05:39:38 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 05:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:38 INFO - Successfully installed psutil 05:39:38 INFO - Cleaning up... 05:39:39 INFO - Return code: 0 05:39:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:39 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 05:39:39 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 05:39:39 INFO - Using env: {'DISPLAY': ':0', 05:39:39 INFO - 'HOME': '/home/cltbld', 05:39:39 INFO - 'LANG': 'en_US.UTF-8', 05:39:39 INFO - 'LANGUAGE': 'en_US:en', 05:39:39 INFO - 'LOGNAME': 'cltbld', 05:39:39 INFO - 'MAIL': '/var/mail/cltbld', 05:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:39 INFO - 'MOZ_NO_REMOTE': '1', 05:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:39 INFO - 'NO_EM_RESTART': '1', 05:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:39 INFO - 'PWD': '/builds/slave/test', 05:39:39 INFO - 'SHELL': '/bin/bash', 05:39:39 INFO - 'SHLVL': '1', 05:39:39 INFO - 'TERM': 'linux', 05:39:39 INFO - 'TMOUT': '86400', 05:39:39 INFO - 'USER': 'cltbld', 05:39:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:39 INFO - '_': '/tools/buildbot/bin/python'} 05:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:42 INFO - Installing collected packages: mozsystemmonitor 05:39:42 INFO - Running setup.py install for mozsystemmonitor 05:39:42 INFO - Successfully installed mozsystemmonitor 05:39:42 INFO - Cleaning up... 05:39:42 INFO - Return code: 0 05:39:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:42 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:42 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 05:39:42 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 05:39:42 INFO - Using env: {'DISPLAY': ':0', 05:39:42 INFO - 'HOME': '/home/cltbld', 05:39:42 INFO - 'LANG': 'en_US.UTF-8', 05:39:42 INFO - 'LANGUAGE': 'en_US:en', 05:39:42 INFO - 'LOGNAME': 'cltbld', 05:39:42 INFO - 'MAIL': '/var/mail/cltbld', 05:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:42 INFO - 'MOZ_NO_REMOTE': '1', 05:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:42 INFO - 'NO_EM_RESTART': '1', 05:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:42 INFO - 'PWD': '/builds/slave/test', 05:39:42 INFO - 'SHELL': '/bin/bash', 05:39:42 INFO - 'SHLVL': '1', 05:39:42 INFO - 'TERM': 'linux', 05:39:42 INFO - 'TMOUT': '86400', 05:39:42 INFO - 'USER': 'cltbld', 05:39:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:42 INFO - '_': '/tools/buildbot/bin/python'} 05:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:45 INFO - Downloading docopt-0.6.1.tar.gz 05:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:45 INFO - Running setup.py install for blobuploader 05:39:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:45 INFO - Running setup.py install for requests 05:39:45 INFO - Running setup.py install for docopt 05:39:45 INFO - Successfully installed blobuploader requests docopt 05:39:45 INFO - Cleaning up... 05:39:45 INFO - Return code: 0 05:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:45 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:45 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 05:39:45 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 05:39:45 INFO - Using env: {'DISPLAY': ':0', 05:39:45 INFO - 'HOME': '/home/cltbld', 05:39:45 INFO - 'LANG': 'en_US.UTF-8', 05:39:45 INFO - 'LANGUAGE': 'en_US:en', 05:39:45 INFO - 'LOGNAME': 'cltbld', 05:39:45 INFO - 'MAIL': '/var/mail/cltbld', 05:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:45 INFO - 'MOZ_NO_REMOTE': '1', 05:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:45 INFO - 'NO_EM_RESTART': '1', 05:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:45 INFO - 'PWD': '/builds/slave/test', 05:39:45 INFO - 'SHELL': '/bin/bash', 05:39:45 INFO - 'SHLVL': '1', 05:39:45 INFO - 'TERM': 'linux', 05:39:45 INFO - 'TMOUT': '86400', 05:39:45 INFO - 'USER': 'cltbld', 05:39:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:45 INFO - '_': '/tools/buildbot/bin/python'} 05:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:45 INFO - Running setup.py (path:/tmp/pip-6UwXMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:46 INFO - Running setup.py (path:/tmp/pip-2bBn0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:46 INFO - Running setup.py (path:/tmp/pip-sApXAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:46 INFO - Running setup.py (path:/tmp/pip-sD4y9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:46 INFO - Running setup.py (path:/tmp/pip-ebDz_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:46 INFO - Running setup.py (path:/tmp/pip-s1T_EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:46 INFO - Running setup.py (path:/tmp/pip-jKELTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:46 INFO - Running setup.py (path:/tmp/pip-6AgnHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:46 INFO - Running setup.py (path:/tmp/pip-O3c136-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:46 INFO - Running setup.py (path:/tmp/pip-7wm5Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:46 INFO - Running setup.py (path:/tmp/pip-iIfQIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:46 INFO - Running setup.py (path:/tmp/pip-OgGZpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:46 INFO - Running setup.py (path:/tmp/pip-AnBgXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:46 INFO - Running setup.py (path:/tmp/pip-JeM7mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:46 INFO - Running setup.py (path:/tmp/pip-8ZLh2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:47 INFO - Running setup.py (path:/tmp/pip-soBBXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:47 INFO - Running setup.py (path:/tmp/pip-4BNygT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:47 INFO - Running setup.py install for manifestparser 05:39:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Running setup.py install for mozcrash 05:39:47 INFO - Running setup.py install for mozdebug 05:39:47 INFO - Running setup.py install for mozdevice 05:39:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Running setup.py install for mozfile 05:39:47 INFO - Running setup.py install for mozhttpd 05:39:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Running setup.py install for mozinfo 05:39:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Running setup.py install for mozInstall 05:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:47 INFO - Running setup.py install for mozleak 05:39:48 INFO - Running setup.py install for mozlog 05:39:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Running setup.py install for moznetwork 05:39:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Running setup.py install for mozprocess 05:39:48 INFO - Running setup.py install for mozprofile 05:39:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Running setup.py install for mozrunner 05:39:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Running setup.py install for mozscreenshot 05:39:48 INFO - Running setup.py install for moztest 05:39:48 INFO - Running setup.py install for mozversion 05:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:48 INFO - Cleaning up... 05:39:48 INFO - Return code: 0 05:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:48 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 05:39:48 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 05:39:48 INFO - Using env: {'DISPLAY': ':0', 05:39:48 INFO - 'HOME': '/home/cltbld', 05:39:48 INFO - 'LANG': 'en_US.UTF-8', 05:39:48 INFO - 'LANGUAGE': 'en_US:en', 05:39:48 INFO - 'LOGNAME': 'cltbld', 05:39:48 INFO - 'MAIL': '/var/mail/cltbld', 05:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:48 INFO - 'MOZ_NO_REMOTE': '1', 05:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:48 INFO - 'NO_EM_RESTART': '1', 05:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:48 INFO - 'PWD': '/builds/slave/test', 05:39:48 INFO - 'SHELL': '/bin/bash', 05:39:48 INFO - 'SHLVL': '1', 05:39:48 INFO - 'TERM': 'linux', 05:39:48 INFO - 'TMOUT': '86400', 05:39:48 INFO - 'USER': 'cltbld', 05:39:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:48 INFO - '_': '/tools/buildbot/bin/python'} 05:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:49 INFO - Running setup.py (path:/tmp/pip-rP5A9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:49 INFO - Running setup.py (path:/tmp/pip-RW67r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:49 INFO - Running setup.py (path:/tmp/pip-5rsBPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:49 INFO - Running setup.py (path:/tmp/pip-8iGM5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:49 INFO - Running setup.py (path:/tmp/pip-EY4eLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:49 INFO - Running setup.py (path:/tmp/pip-SND9zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:49 INFO - Running setup.py (path:/tmp/pip-oq8Wpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:49 INFO - Running setup.py (path:/tmp/pip-fyvXMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:49 INFO - Running setup.py (path:/tmp/pip-CTd6vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:49 INFO - Running setup.py (path:/tmp/pip-4T4pQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:49 INFO - Running setup.py (path:/tmp/pip-hEl3mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:49 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)) 05:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:49 INFO - Running setup.py (path:/tmp/pip-w8GCae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:50 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)) 05:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:50 INFO - Running setup.py (path:/tmp/pip-i2lYiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:50 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)) 05:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:50 INFO - Running setup.py (path:/tmp/pip-VAC0F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:50 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)) 05:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:50 INFO - Running setup.py (path:/tmp/pip-AUezWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:50 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)) 05:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:50 INFO - Running setup.py (path:/tmp/pip-Ev9nod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:50 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)) 05:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:50 INFO - Running setup.py (path:/tmp/pip-3VP3LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:52 INFO - Downloading blessings-1.6.tar.gz 05:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:52 INFO - Installing collected packages: blessings 05:39:52 INFO - Running setup.py install for blessings 05:39:52 INFO - Successfully installed blessings 05:39:52 INFO - Cleaning up... 05:39:52 INFO - Return code: 0 05:39:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:52 INFO - Reading from file tmpfile_stdout 05:39:52 INFO - Current package versions: 05:39:52 INFO - argparse == 1.2.1 05:39:52 INFO - blessings == 1.6 05:39:52 INFO - blobuploader == 1.2.4 05:39:52 INFO - docopt == 0.6.1 05:39:52 INFO - manifestparser == 1.1 05:39:52 INFO - mozInstall == 1.12 05:39:52 INFO - mozcrash == 0.17 05:39:52 INFO - mozdebug == 0.1 05:39:52 INFO - mozdevice == 0.48 05:39:52 INFO - mozfile == 1.2 05:39:52 INFO - mozhttpd == 0.7 05:39:52 INFO - mozinfo == 0.9 05:39:52 INFO - mozleak == 0.1 05:39:52 INFO - mozlog == 3.2 05:39:52 INFO - moznetwork == 0.27 05:39:52 INFO - mozprocess == 0.22 05:39:52 INFO - mozprofile == 0.28 05:39:52 INFO - mozrunner == 6.11 05:39:52 INFO - mozscreenshot == 0.1 05:39:52 INFO - mozsystemmonitor == 0.3 05:39:52 INFO - moztest == 0.7 05:39:52 INFO - mozversion == 1.4 05:39:52 INFO - psutil == 3.1.1 05:39:52 INFO - requests == 1.2.3 05:39:52 INFO - wsgiref == 0.1.2 05:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:52 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')]} 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 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')]} 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:52 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 05:39:52 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 05:39:52 INFO - Using env: {'DISPLAY': ':0', 05:39:52 INFO - 'HOME': '/home/cltbld', 05:39:52 INFO - 'LANG': 'en_US.UTF-8', 05:39:52 INFO - 'LANGUAGE': 'en_US:en', 05:39:52 INFO - 'LOGNAME': 'cltbld', 05:39:52 INFO - 'MAIL': '/var/mail/cltbld', 05:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:52 INFO - 'MOZ_NO_REMOTE': '1', 05:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:52 INFO - 'NO_EM_RESTART': '1', 05:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:52 INFO - 'PWD': '/builds/slave/test', 05:39:52 INFO - 'SHELL': '/bin/bash', 05:39:52 INFO - 'SHLVL': '1', 05:39:52 INFO - 'TERM': 'linux', 05:39:52 INFO - 'TMOUT': '86400', 05:39:52 INFO - 'USER': 'cltbld', 05:39:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:52 INFO - '_': '/tools/buildbot/bin/python'} 05:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 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)) 05:39:52 INFO - Cleaning up... 05:39:52 INFO - Return code: 0 05:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:52 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')]} 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 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')]} 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:52 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 05:39:52 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 05:39:52 INFO - Using env: {'DISPLAY': ':0', 05:39:52 INFO - 'HOME': '/home/cltbld', 05:39:52 INFO - 'LANG': 'en_US.UTF-8', 05:39:52 INFO - 'LANGUAGE': 'en_US:en', 05:39:52 INFO - 'LOGNAME': 'cltbld', 05:39:52 INFO - 'MAIL': '/var/mail/cltbld', 05:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:52 INFO - 'MOZ_NO_REMOTE': '1', 05:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:52 INFO - 'NO_EM_RESTART': '1', 05:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:52 INFO - 'PWD': '/builds/slave/test', 05:39:52 INFO - 'SHELL': '/bin/bash', 05:39:52 INFO - 'SHLVL': '1', 05:39:52 INFO - 'TERM': 'linux', 05:39:52 INFO - 'TMOUT': '86400', 05:39:52 INFO - 'USER': 'cltbld', 05:39:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:52 INFO - '_': '/tools/buildbot/bin/python'} 05:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:53 INFO - Downloading/unpacking jsonschema 05:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:55 INFO - warning: no files found matching '*.txt' 05:39:55 INFO - no previously-included directories found matching 'build' 05:39:55 INFO - no previously-included directories found matching 'dist' 05:39:55 INFO - no previously-included directories found matching '.git*' 05:39:55 INFO - Installing collected packages: jsonschema, functools32 05:39:55 INFO - Running setup.py install for functools32 05:39:55 INFO - warning: no files found matching '*.txt' 05:39:55 INFO - no previously-included directories found matching 'build' 05:39:55 INFO - no previously-included directories found matching 'dist' 05:39:55 INFO - no previously-included directories found matching '.git*' 05:39:55 INFO - Successfully installed jsonschema functools32 05:39:55 INFO - Cleaning up... 05:39:55 INFO - Return code: 0 05:39:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:39:55 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')]} 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:55 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')]} 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:55 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 0x7ff09ef7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', '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 05:39:55 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 05:39:55 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 05:39:55 INFO - Using env: {'DISPLAY': ':0', 05:39:55 INFO - 'HOME': '/home/cltbld', 05:39:55 INFO - 'LANG': 'en_US.UTF-8', 05:39:55 INFO - 'LANGUAGE': 'en_US:en', 05:39:55 INFO - 'LOGNAME': 'cltbld', 05:39:55 INFO - 'MAIL': '/var/mail/cltbld', 05:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:55 INFO - 'MOZ_NO_REMOTE': '1', 05:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:55 INFO - 'NO_EM_RESTART': '1', 05:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:55 INFO - 'PWD': '/builds/slave/test', 05:39:55 INFO - 'SHELL': '/bin/bash', 05:39:55 INFO - 'SHLVL': '1', 05:39:55 INFO - 'TERM': 'linux', 05:39:55 INFO - 'TMOUT': '86400', 05:39:55 INFO - 'USER': 'cltbld', 05:39:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:55 INFO - '_': '/tools/buildbot/bin/python'} 05:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:55 INFO - Downloading/unpacking flake8 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:39:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:39:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:39:58 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 05:39:58 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 05:39:58 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 05:39:58 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 05:39:58 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 05:39:58 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 05:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:58 INFO - no previously-included directories found matching 'docs/_build' 05:39:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:39:58 INFO - Running setup.py install for pep8 05:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:58 INFO - no previously-included directories found matching 'docs/_build' 05:39:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:39:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:39:58 INFO - Cleaning up... 05:39:58 INFO - Return code: 0 05:39:58 INFO - Running post-action listener: _resource_record_post_action 05:39:58 INFO - Running post-action listener: _start_resource_monitoring 05:39:58 INFO - Starting resource monitoring. 05:39:58 INFO - ##### 05:39:58 INFO - ##### Finished create-virtualenv step (success) 05:39:58 INFO - ##### 05:39:58 INFO - ##### 05:39:58 INFO - ##### Running install step. 05:39:58 INFO - ##### 05:39:58 INFO - Running pre-action listener: _resource_record_pre_action 05:39:58 INFO - Running main action method: install 05:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:58 INFO - Reading from file tmpfile_stdout 05:39:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:58 INFO - Reading from file tmpfile_stdout 05:39:58 INFO - Output received: 05:39:58 INFO - Usage: mozinstall [options] installer 05:39:58 INFO - Options: 05:39:58 INFO - -h, --help show this help message and exit 05:39:58 INFO - -d DEST, --destination=DEST 05:39:58 INFO - Directory to install application into. [default: 05:39:58 INFO - "/builds/slave/test"] 05:39:58 INFO - --app=APP Application being installed. [default: firefox] 05:39:58 INFO - mkdir: /builds/slave/test/build/application 05:39:58 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'] 05:39:58 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 05:40:15 INFO - Reading from file tmpfile_stdout 05:40:15 INFO - Output received: 05:40:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:15 INFO - Running post-action listener: _resource_record_post_action 05:40:15 INFO - ##### 05:40:15 INFO - ##### Finished install step (success) 05:40:15 INFO - ##### 05:40:15 INFO - ##### 05:40:15 INFO - ##### Running run-tests step. 05:40:15 INFO - ##### 05:40:15 INFO - Running pre-action listener: _resource_record_pre_action 05:40:15 INFO - Running main action method: run_tests 05:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:15 INFO - Python 2.7.3 05:40:15 INFO - Return code: 0 05:40:15 INFO - grabbing minidump binary from tooltool 05:40: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')]} 05:40:15 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 0x1d709c0>, '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 0x1d718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d71d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:15 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 05:40:15 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 05:40:15 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 05:40:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:15 INFO - Return code: 0 05:40:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:40:16 INFO - Return code: 0 05:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 05:40:16 INFO - Using env: {'DISPLAY': ':0', 05:40:16 INFO - 'HOME': '/home/cltbld', 05:40:16 INFO - 'LANG': 'en_US.UTF-8', 05:40:16 INFO - 'LANGUAGE': 'en_US:en', 05:40:16 INFO - 'LOGNAME': 'cltbld', 05:40:16 INFO - 'MAIL': '/var/mail/cltbld', 05:40:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:16 INFO - 'MOZ_NO_REMOTE': '1', 05:40:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:16 INFO - 'NO_EM_RESTART': '1', 05:40:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:16 INFO - 'PWD': '/builds/slave/test', 05:40:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:16 INFO - 'SHELL': '/bin/bash', 05:40:16 INFO - 'SHLVL': '1', 05:40:16 INFO - 'TERM': 'linux', 05:40:16 INFO - 'TMOUT': '86400', 05:40:16 INFO - 'USER': 'cltbld', 05:40:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149', 05:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:16 INFO - '_': '/tools/buildbot/bin/python'} 05:40:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:40:16 INFO - mozversion application_buildid: 20160526030223 05:40:16 INFO - mozversion application_changeset: 8d0aadfe7da782d415363880008b4ca027686137 05:40:16 INFO - mozversion application_display_name: Nightly 05:40:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:16 INFO - mozversion application_name: Firefox 05:40:16 INFO - mozversion application_remotingname: firefox 05:40:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:16 INFO - mozversion application_vendor: Mozilla 05:40:16 INFO - mozversion application_version: 49.0a1 05:40:16 INFO - mozversion platform_buildid: 20160526030223 05:40:16 INFO - mozversion platform_changeset: 8d0aadfe7da782d415363880008b4ca027686137 05:40:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:16 INFO - mozversion platform_version: 49.0a1 05:40:16 INFO - using testdate: 1464266416 05:40:16 INFO - actual date: 1464266416 05:40:16 INFO - starting webserver on 'localhost:50209' 05:40:16 INFO - SUITE-START | Running 2 tests 05:40:16 INFO - TEST-START | dromaeo_css 05:40:16 INFO - operating with platform_type : linux_ 05:40:16 INFO - Initialising browser for dromaeo_css test... 05:40:16 INFO - TEST-INFO | started process 6296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSODTxn/profile http://localhost:50209/getInfo.html) 05:40:20 INFO - PROCESS | 6296 | 05:40:20 INFO - PROCESS | 6296 | (process:6365): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:21 INFO - PROCESS | 6296 | __metrics Screen width/height:1600/1200 05:40:21 INFO - PROCESS | 6296 | colorDepth:24 05:40:21 INFO - PROCESS | 6296 | Browser inner width/height: 1024/697 05:40:21 INFO - PROCESS | 6296 | __metrics 05:40:22 ERROR - PROCESS | 6296 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:40:22 INFO - TEST-INFO | 6296: exit 0 05:40:23 INFO - Browser initialized. 05:40:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:23 INFO - TEST-INFO | started process 6416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSODTxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:24 INFO - PROCESS | 6416 | 05:40:24 INFO - PROCESS | 6416 | (process:6477): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:34 INFO - PROCESS | 6416 | RSS: Main: 166285312 05:40:34 INFO - PROCESS | 6416 | 05:41:24 INFO - PROCESS | 6416 | 1464266484531 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] 05:43:31 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50209/tests/dromaeo/cssquery-ext.html) 05:43:32 INFO - PROCESS | 6416 | RSS: Main: 169672704 05:43:32 INFO - PROCESS | 6416 | 05:46:34 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-ext.html (next: http://localhost:50209/tests/dromaeo/cssquery-jquery.html) 05:46:35 INFO - PROCESS | 6416 | RSS: Main: 169390080 05:46:35 INFO - PROCESS | 6416 | 05:49:37 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50209/tests/dromaeo/cssquery-mootools.html) 05:49:37 INFO - PROCESS | 6416 | RSS: Main: 170582016 05:49:37 INFO - PROCESS | 6416 | 05:52:39 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50209/tests/dromaeo/cssquery-prototype.html) 05:52:40 INFO - PROCESS | 6416 | RSS: Main: 167960576 05:52:40 INFO - PROCESS | 6416 | 05:55:42 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50209/tests/dromaeo/cssquery-yui.html) 05:55:43 INFO - PROCESS | 6416 | RSS: Main: 168964096 05:55:43 INFO - PROCESS | 6416 | 05:58:45 INFO - PROCESS | 6416 | Cycle 1(1): loaded http://localhost:50209/tests/dromaeo/cssquery-yui.html (next: http://localhost:50209/tests/dromaeo/cssquery-dojo.html) 05:58:46 INFO - PROCESS | 6416 | RSS: Main: 171544576 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | __start_tp_report 05:58:46 INFO - PROCESS | 6416 | _x_x_mozilla_page_load 05:58:46 INFO - PROCESS | 6416 | _x_x_mozilla_page_load_details 05:58:46 INFO - PROCESS | 6416 | |i|pagename|runs| 05:58:46 INFO - PROCESS | 6416 | |0;dojo.html;3125.7655675824317;3145.103645461044;3164.1614972032417;3174.206448387903;3184.2357834119803;5374.865628359293;5503.174523821429;5528.143137813645;5545.77816887325;5597.188407680884;5402.729863506828;5445.918311225325;5470.835874923759;5480.588955828319;5566.304211973493;4935.531124543163;4971.105201063798;5005.549500544968;5017.799288028475;5090.516400941905;411.9036223981418;4966.528179822929;5045.091883460976;5073.112205364065;5097.847064588068;4905.117078925792;4964.007198560303;4965.131102057144;5009.674371165881;5032.547070763649;5035.521625445577;5035.6978581284875;5039.874003149914;5064.3163172971545;5089.847304580869;4952.158133117343;4960.057589058068;4965.82619608312;5021.5229553192385;5024.171011783052;5389.622726409114;5424.728763561806;5468.589855760833;5492.47821456961;5493.23094766733;5913.172155898178;5946.910796338058;5947.910781338283;5955.166276721263;5963.4334738199805;5816.040353341736;5872.677002764846;5884.293884733816;5922.378150294243;5949.791757288517;5527.695976721278;5554.638948468377;5555.805546805883;5567.638103523258;5586.720663966786;5888.587798854039;6077.726502307407;6089.1779609753;6099.817005489843;6114.11345354921;5790.420957904176;5805.651660900359;5858.238429004202;5879.294484661782;5900.734466948998;5960;5974.253218347707;5974.790882319098;5975.073863551156;5980.282366116007;5702.942970570324;5864.296284445893;5874.94125058744;5877.353491115974;5890.911636325459;5941.970290148522;5973.104034394875;5973.522118230618;5975.611585246945;6025.638461692312;4491;4498.437695288089;4506.076254367847;4526.637868970474;4560.110778398247;3902.590228026073;3950.6246906543834;3967.900802479961;4017.678585713136;4046.2716710991717;5565.165225216169;5633.9858825411;5708.600397972102;5721.056025755787;5737.3688894221605;5969.492593129546;5995.790147344822;6010.158577799111;6015.4586087252355;6023.488003519662;5551.084071128219;5671.773129074791;5702.942970570241;5721.828345149652;5746.770129194869;4977.178765503724;4980.252962055721;4982.377202849644;4985.825496107619;5013.097642424399;6151.630902145886;6176.227971503562;6189.6286222826775;6192.504599632019;6195.721192546346;5725.685087320154;5921.082232254007;5953.434423729739;5962.940370596412;5983.9401605983385;6122.663253521099;6159.692015399301;6172.969135154295;6200.782972595937;6208.658523781235;5835.066389377679;5866.120081987565;5894.292684877671;5896.321922978741;5910.852228694317;5888.116782482491;5922.851928701817;5929.6145750526075;6008.218931538872;6039.48664363534;5826.067829147316;5829.446202610745;5844.26946631671;5862.765489380377;5880.8235752927485;5680.176374425768;5855.531557475307;5856.648601083949;5863;5870.090136028923;5679.943200567942;5736.569757268138;5741.25363702716;5763.884722305615;5783.248177736868;5797.623154495113;5810.012297909281;5851.970740146272;5874.03078492044;5874.118882167709;5521.503064724034;5656.971715141398;5726.226959360433;5770.394108618702;5794.420557944172 05:58:46 INFO - PROCESS | 6416 | |1;ext.html;583.7110630238033;628.7642134199675;649.619972316195;670.1355251725274;675.1864003875331;40587.59412405875;44190.999999999956;44210;44285.7785711071;44511;44679.77660111703;45482.090358192814;45666;45721;45818;8712.825743485142;8902.821943561157;8907.955460222689;8910.50992195429;8913.108689131068;8797.560121993874;8836.734897953073;8849.07084756101;8854.601542930584;8873.068327825582;8871.334649901251;8881.822363552725;8918.687845925393;8924.062973387798;8992.77518062047;8795.296376289882;8883;8895.154960278764;8895.644174233023;8967.103289671046;8773.517456539888;8820.117988201193;8839.558022098934;8869.246114080246;8877;32951.6704832951;42257.78871105625;42439.57560424387;42745.145097097884;42934.78532607317;3355.6644335566248;3361.226917808893;3473.930521389558;3550.9822450887837;3611.9097022574383;32058;32470.675293247237;32595;32723.18192045194;33059;3862.6009111981557;3898.3762597984187;3948.6643635291034;3995;4015.3976903464422;307039;309539;309763;310163;311894;34818.129546761535;35203.4719479208;35576.466353004726;36048.81975590105;36091.097722556624;37151.25697486035;37408;37448.812755936044;37499.625003749614;37551.81224093862;15335.693286134216;15504.922475387777;15564.610884727746;15597.610059748597;15626.140562269184;12522.624321270376;12601.936990315173;12663.240205587694;12667.36663166838;12691;8375.539345335943;8415.537145456936;8466.957665211634;8487.10885357041;8557.529335886586;3240.8541615627355;3251.1059458648588;3333.6332103837312;3334.4664853623303;3393.100828280508;1022.3405903192399;1102.3000394749392;1205.421397729095;1211.9091068169923;1216.6410908781754;33622.663773362445;34023.659763402546;34087.147821304665;34342;34594.13514662103;1195.5337418406828;1231.969200769988;1236.536298887917;1262.958059600833;1301.5769874790542;17667.20497577612;17699.20353584092;17731;17810;17932.282708691506;557535;563036;563239;565060;566214;40113.1977360457;41069.38395924064;41087;41136.971575710246;41294.79352603278;1366.760816857066;1378.1111183286723;1383.100984360174;1398.2100113435877;1404.3527949814672;31524.842375787975;33376.1655958603;33898.49152262669;33923;33994;52696.209556857444;53285;53325.200121998976;53414.4658553425;53566.732166338916;440820;443763;449224;449482;449942;28493.287667807643;28701.28246793847;28703.712962870104;28805.27986800347;29002.7099729;50293;50810.23784643159;52024.21963670472;54425.455745442036;55399.44600553943;42998.785006074766;45449.545504544534;46265.3060204104;47890;48499.27251091166;46563.53436465727;46768.89702662975;47201;47480;47550;39820;45527;46013.76993115013;47803.76098119487;48952.75523622359;42325.36511952385;46336.76831615955;46718.299225512324;46931.53068469271;47154.764226178646;35546.82619408215;36270.63729362673;36730.26539469142;37009.62990370062;37107.6289237115 05:58:46 INFO - PROCESS | 6416 | |2;jquery.html;392.39962856829044;397.40389415876183;398.1042654028436;404.6216787303871;418.2492426095159;18132.728009079874;19269.807301926976;19567.41297761066;19597.70603440948;19787.307444239454;17955.73066404005;18400;18612.441626751184;19297.807021929777;19300.227990880347;5701.74342154602;5741.741621627016;5750.942490575104;5790.131480277971;5955.523558115362;5768.82693519193;5788.305403351604;5807.593468457209;5840.0947853082625;5846.970765146169;5710.2862142232225;5758.136279558058;5777.653340799566;5809.157672137538;5830.912536311958;5756.107803290497;5757.9712101439645;5807.2160258365;5807.738651760681;5845.415458454163;5036.722980236085;5145.536901678829;5173.663711858717;5184.974075129638;5196;19455.319063832838;22824.65763013556;23426.414339641477;23535.764102410245;23717.88141059301;2334.976650233493;2348.189874493297;2478.1202673051166;2537.3402915241986;2909.6653884803095;14266.429342826275;14289.142651440947;14456.71086578273;14603.196824174665;14834.703305933821;1932.9226830926887;1986.5430950881378;1996.8602197846012;2000.8499362547868;2012.8691635043676;66362.66818665924;81310.59344703238;82399.58800205961;82541.58729206315;83431.582842086;10180.541875615467;10524.842127368096;10775;10823.783524329468;10955.945220273848;14473.638159046108;14606.196659183846;14615;14693.55919322422;14713.55859324222;7819.335356494648;7940.880886786703;8246.463979841292;8320.459170153921;8609.526476043879;8240.258376746122;8280.751577452686;8367.58162091905;8486.236238738544;8573.699920502753;6596.86806263872;6622.072909792633;6715.529912906148;6774.593524388552;6799.558028728117;1925.210663627906;1934.6517626827306;1937.6318499485053;1952.1215453045902;1964.9607007859763;955.1499165742356;973.090160699748;1074.6023971130576;1109.0074383426788;1140.3670962615827;19813.20747170097;20292.347377471902;20355.491112722004;20571.38285851427;20707.27524536634;1059.195011791029;1069.1446842525947;1083.0685610375072;1104.861892263467;1128.2948157401624;11105.777884442266;11654.359010254348;11670.474828632732;11687;11694.2983420995;454192;464731;465009;467142;469320;82150.58924705339;83239.58380208182;83477.16522834694;83537;84128.57935710404;1048.4233671480656;1064.5794911010107;1070.4808168038496;1088.9292196007234;1092.9890701093045;17581.648367032332;17918.91040544789;17940.820591793916;18113.728294075863;18244;36285;37458;38967.22065558616;39586.99999999885;40596.3910541348;51482;53193.73403132959;53650.19524707211;54310;55064;7583.090029196532;8604.569771511524;8707.346948978726;8899.510526920823;8901.198892099743;11876.524939002344;13651.249181295125;13991.720165596835;14036;14111.647208819862;11917.284962902253;12433.937830311152;12450.003999679822;12457.065720071212;12486.063545234325;11876.821847672465;11898;12019.699507512381;12163.817542737042;12374.319412432042;11566.94216528912;11796.882031179579;12103.455344509342;12439.253644781342;12803.679908002374;7754.9530813341735;8026.43814932949;8166.836663266583;8175.509469431853;8182.22268884455;11164.720881978015;11339.149563782914;11605.6518304451;11818;11995.940020299842 05:58:46 INFO - PROCESS | 6416 | |3;mootools.html;1535.1556643845881;1540.5532395605273;1703.6507515959229;1804.4586624012793;1836.9173387197575;8123.715669951553;8815.603297851596;8890.911090889089;9374.85937710935;9389.577469013886;8884.422512536697;9242.537873106352;9309.069093090688;9332.346735728503;9336.393134446256;2378.7621237876247;2396;2400.243923164198;2411.807055435561;2413.1312727418203;2330.33585428153;2331.708536432946;2378.7383387827413;2382.059086660768;2393.7366889642126;2320.6867072945106;2346.2843832631042;2378.54807586558;2448.289995901195;2454.460018795862;2325.4883925536355;2336.0538981712434;2337.9532409351805;2345.554344674515;2377.7265614454386;2354.176038386551;2355.1521452277166;2356.0340260493285;2358.0803486640225;2391.175044609607;9183.770405739842;9220.262379009662;9234.215091717213;9239;9247.861282080774;5282.947170528322;5359.356877174725;5378.327709036371;5412.56699464042;5412.810551630674;3420.863165473378;3439.810810405452;3503.24680193757;3614.4939708440575;3616.4032934565766;1133.1784456269222;1170.6195486466931;1189.02499950041;1215.398377802993;1232.5686009896554;12632.49470021198;12734.299613521252;12749.617511474671;12772.425240864277;12776.169548979287;4718.243349598566;4789.137955168034;4849.660523763303;4886.315915771795;4900.754962251873;10067.949660251652;10075.697729068139;10077.69766906994;10082.848757268646;10085.647002354883;5335.253064570963;5382.138857782736;5392.78428862849;5431.076716958048;5520.779168833202;4593.839215627437;4919.729414882144;5048.192289233705;5057.898842023213;5065.037642847848;3930.3514920037874;3957.1887763008513;3961.6830653547645;4055.8986025349013;4094.774787386663;1188.3582865252667;1199.8320235167084;1203.0195390756505;1205.8311836342918;1232.9013678905667;879.2877769007125;957.095544710256;1033.788073444942;1042.8122937871103;1045.8535804987307;6220.911340515482;6263.812085637438;6276.968615156895;6391.169148010822;6397.744090236339;453.59629929362893;473.091664005111;1048.7168464514539;1121.2767764791827;1127.0701671121358;4145.66834653233;4326.3510473428605;4370.934435983399;4411.117776444724;4453.421055262795;11330.320180789178;11642.94178529102;11760.117991150526;11791.764164716658;11842.348670823187;11237.269577477438;11646.650600481998;11657;11664.708382290512;11677.941610291895;8529.294141171791;8573.18554737299;8609.827803443895;8671.696490622924;8694.434861733967;5393.352797664148;5405.00119645837;5406.432324605859;5421.403645598902;5493.505584497414;10550.683479495627;10656.094231990057;10669.679909602724;10671.199660025373;10748.62379816734;10623.150147988297;10853.294535855144;10885;11025.228234023542;11073.833892491459;7007.159140902921;7298.379637730853;7473.327400533978;7754.224577542201;7909.288164065261;8767.60545775429;8818.647254110021;8821.985471670583;8838.64645414202;8889.64441422336;7567.583782891774;7819.100803407681;7887;7939.126696063544;7953.6023198840985;7681.577513236825;7729.768106956801;7798.025246844145;7819.0617125945255;7965.123836378109;7231.16841563227;7260.854782904418;7353.154387245535;7387.7783666490095;7396.593187374746;5199.220116982483;5260.8158714446345;5313.893722125613;5353.304070470814;5375.19372094189;5049.974750126373;5114.71869047206;5247.475252474722;5383.919241211307;5539.169124631177 05:58:46 INFO - PROCESS | 6416 | |4;prototype.html;310.82593747501403;317.72675499070795;320.40085040973366;336.6498841205147;340.55387442450376;5447.809326673567;5491.9290738305945;5580.804671836487;5682.801101961432;5703.0589952657765;5627.577931655122;5628.859278518039;5628.971855140719;5636.379998200205;5650.858728531789;4330.956690433095;4354.651627869779;4366.628836548897;4372.2130016597;4382.737035777847;4107.870335657703;4360.21516127097;4363.607275345218;4396.912061758763;4413.6027757501815;4284.657227421814;4296.355546667994;4304.591063848945;4305.892352691192;4311.547287534795;4290.485141783006;4304.182205380967;4308.633766129883;4331.718438301532;4334.783260836962;3589.964100358989;3764.3788774852114;3769.1142581493327;3790.8104594770152;3794.848206071754;5403.297571315743;5430.212619170237;5434.945650543484;5451.863703407407;5487.6981766002855;4872.317875497433;4898.632602554787;4937.629677774181;4941.135301322291;4955.900881982377;5434.91847622286;5847.2983242010805;5856.6031701612965;5924.318703349084;5954.315253745788;4088.6524645405175;4096.40602112692;4126.926998980287;4131.628153466172;4164.56272091429;6042.57701960863;6054.485368743618;6129.846753831145;6136;6140.907886381708;4125.50493940723;4202.739178246514;4218.198542276958;4257.488591550017;4259.254630439661;4220.2192594370135;4222.577742225752;4238.237117318912;4242.384854196124;4290.313549832012;4825.30033145192;4896.46138924718;4931.9753401232765;4939.75301234944;4955.950440495549;5723.313202415654;5839;5876.41235876409;5979.252593425822;6013.188219590299;1464.7509923313062;1468.1411374345914;1481.3185934470048;1483.3325003748357;1490.3814916809404;895.9059298773535;932.9813403731887;939.6006697153682;945.0313428735464;949.8222204466412;4985.875353116128;5036.697798132123;5045.495450454999;5049.747512624354;5165.560927321219;5303.310569626001;5339.759710813023;5351;5444.128939369761;5453.391249581383;5009.793732011515;5088.567471764867;5137.563307118937;5270.549194624518;5762.9135562966585;3202.967970320267;3204.2630195055267;3205.7275131613605;3225.59680039995;3243.8053716777067;6040.275166979903;6238.906416403757;6257.249130104326;6288.874222515616;6290.087937249074;6098.26820781509;6138.5396095292135;6141;6150.261968563712;6168.722407491674;6251.999040460513;6267.151190398843;6276.309605943434;6280.685965701788;6301.52738544611;5765.4811067004175;5913.733881975236;5967.7016149191495;6034.487068599218;6037.788677396446;5919.822405327847;5943.583949123693;5978.880422391441;5998.400159984141;6011.278646562266;6033;6266.843328916631;6290.2766181889665;6328.968355158379;6334.334894835976;4151.916961660811;4158.417821505052;4160.628441788152;4161.52142503616;4170.72890262132;6053.72985130576;6057.545684073624;6059.757609695563;6066.241719785027;6068.271807383142;5530.391656917816;5843.853903652443;5849.473547380756;5880;5926.644401335933;5910.940890591039;5916.290045194432;5925.792597259076;5928.199693041557;5936.554758393051;5572.841731095584;5778.653280803165;5799.536037116936;5823;5842.591018628656;5815.709214539172;5854.677992710442;5882.735276912464;5909.172715819703;5928.828076978795;5792.017111187826;5810.273715785527;5813.854653633693;5819.79630712923;5827.475527202572 05:58:46 INFO - PROCESS | 6416 | |5;yui.html;748.4872862089466;754.3098065270275;763.9618019099047;810.6473683947481;848.2196379331017;12892.226466411998;14258.287085645728;14869.553913382602;15390.69218615627;15792.97345672532;14693.632659183526;15115.6976860463;15159.848401515981;15205.239738013082;15281.2359382031;799.360511590728;806.899137607799;807.6325272001254;807.6890397197062;811.6469335838899;822.6092606012156;822.7120507822274;822.942394032415;824.9133840946704;825.0470706334194;859.6002858670716;860.4407135362002;861.1732736572866;863.4560227056945;865.6623916672503;851.3231980575457;853.8463076646201;860.3633311349619;861.0657436681208;865.2818160926416;611.9816405507797;616.8982117950533;617.1113596421139;623.4513628007325;633.1673848888743;13378.531751388655;13399.732005359936;13485.190888546718;13577.59267221985;13587.864121358758;13567.86432135676;14052.36764345607;14059.718805623932;14086.929565352108;14294;10445.477726113664;10507.632232871812;10768.892311076866;10843.512041958053;10861.511231994578;3864.845406183749;3897.61023897608;3996.760194388346;4030.858919937788;4069.9389509157386;61662.69168654173;63386;63600;63909;63992.360076399105;10585.57657693699;10651.946740266249;10732.839007414896;10793.67618971432;11142.554297827995;19438.70841937372;19540.609187816164;19548.218071277275;19579.042095790308;19582;7721.073471183494;7796.4932279401655;7938.960305198552;7952.357497873098;8255.047863612243;4511.774411279423;4563.338315944169;4662.836800711959;4684.414448193976;4712.95287047132;3399.66003399663;3476.252605689738;3488.0582242794303;3488.302339532104;3491.6159222486012;612.3967891626744;623.1462895832739;625.6965371794676;628.2931701835436;635.3170341882402;735.3565630073685;746.6565379925187;752.5221484357363;758.6737702787855;792.6750032486768;9411.858822117674;9419.340646154704;9612.855807162898;9664;9675.90324096764;564.2777245126244;651.7824812376892;679.5650783498564;689.7378995981595;695.7321431248904;4534.183846907522;4752.952470475251;4755.358026666425;4761.880952976134;4775.5224477552665;67018;70421.2957870425;72174.27825721781;72819.27180728124;73134;63941.36058639447;64210.67894660497;64284;65741;66061;56500.717496413075;56737.71631141818;57119.42880571224;57192.71403642955;57860;9035.864462032943;9186.954065229631;9189.816203676022;9193.816123677356;9240.768980775534;39016.60983390243;39236;39408.60591394164;39577.406338904366;39945.80027099846;46689;47989;49766;51434;51872.109591781526;12050.75898482043;12163.331016794162;12238.816417753918;12512.687182820502;12614.55849045279;13441.865581344062;13793.412949711954;14227.50203742864;14410.855891440951;14485.7827132591;13059.934700326437;13077.149985250928;13452.865471345161;13521;13813.792793108312;12995.155314904501;13051.738965220453;13259.337033148111;13406.932965335502;14244.216568088854;12390.380480976095;12558.937205313914;13261.138026028277;13622.182669039888;13638.045336826326;10434.68695939123;10460.26778125524;10603.840942386025;10757.838632420677;10838.187135964992;11309.20835541537;11311.321320720783;11323;11404.657860263873;11578.826317605075 05:58:46 INFO - PROCESS | 6416 | __end_tp_report 05:58:46 INFO - PROCESS | 6416 | __start_cc_report 05:58:46 INFO - PROCESS | 6416 | _x_x_mozilla_cycle_collect,345 05:58:46 INFO - PROCESS | 6416 | __end_cc_report 05:58:46 INFO - PROCESS | 6416 | __startTimestamp1464267526224__endTimestamp 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | ------- Summary: start ------- 05:58:46 INFO - PROCESS | 6416 | Number of tests: 6 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#0] dojo.html Cycles:165 Average:5475.95 Median:5741.25 stddev:760.42 (13.2%) stddev-sans-first:740.07 05:58:46 INFO - PROCESS | 6416 | Values: 3125.8 3145.1 3164.2 3174.2 3184.2 5374.9 5503.2 5528.1 5545.8 5597.2 5402.7 5445.9 5470.8 5480.6 5566.3 4935.5 4971.1 5005.5 5017.8 5090.5 411.9 4966.5 5045.1 5073.1 5097.8 4905.1 4964.0 4965.1 5009.7 5032.5 5035.5 5035.7 5039.9 5064.3 5089.8 4952.2 4960.1 4965.8 5021.5 5024.2 5389.6 5424.7 5468.6 5492.5 5493.2 5913.2 5946.9 5947.9 5955.2 5963.4 5816.0 5872.7 5884.3 5922.4 5949.8 5527.7 5554.6 5555.8 5567.6 5586.7 5888.6 6077.7 6089.2 6099.8 6114.1 5790.4 5805.7 5858.2 5879.3 5900.7 5960.0 5974.3 5974.8 5975.1 5980.3 5702.9 5864.3 5874.9 5877.4 5890.9 5942.0 5973.1 5973.5 5975.6 6025.6 4491.0 4498.4 4506.1 4526.6 4560.1 3902.6 3950.6 3967.9 4017.7 4046.3 5565.2 5634.0 5708.6 5721.1 5737.4 5969.5 5995.8 6010.2 6015.5 6023.5 5551.1 5671.8 5702.9 5721.8 5746.8 4977.2 4980.3 4982.4 4985.8 5013.1 6151.6 6176.2 6189.6 6192.5 6195.7 5725.7 5921.1 5953.4 5962.9 5983.9 6122.7 6159.7 6173.0 6200.8 6208.7 5835.1 5866.1 5894.3 5896.3 5910.9 5888.1 5922.9 5929.6 6008.2 6039.5 5826.1 5829.4 5844.3 5862.8 5880.8 5680.2 5855.5 5856.6 5863.0 5870.1 5679.9 5736.6 5741.3 5763.9 5783.2 5797.6 5810.0 5852.0 5874.0 5874.1 5521.5 5657.0 5726.2 5770.4 5794.4 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#1] ext.html Cycles:180 Average:59245.99 Median:41111.99 stddev:120161.96 (292.3%) stddev-sans-first:120418.33 05:58:46 INFO - PROCESS | 6416 | Values: 583.7 628.8 649.6 670.1 675.2 40587.6 44191.0 44210.0 44285.8 44511.0 44679.8 45482.1 45666.0 45721.0 45818.0 8712.8 8902.8 8908.0 8910.5 8913.1 8797.6 8836.7 8849.1 8854.6 8873.1 8871.3 8881.8 8918.7 8924.1 8992.8 8795.3 8883.0 8895.2 8895.6 8967.1 8773.5 8820.1 8839.6 8869.2 8877.0 32951.7 42257.8 42439.6 42745.1 42934.8 3355.7 3361.2 3473.9 3551.0 3611.9 32058.0 32470.7 32595.0 32723.2 33059.0 3862.6 3898.4 3948.7 3995.0 4015.4 307039.0 309539.0 309763.0 310163.0 311894.0 34818.1 35203.5 35576.5 36048.8 36091.1 37151.3 37408.0 37448.8 37499.6 37551.8 15335.7 15504.9 15564.6 15597.6 15626.1 12522.6 12601.9 12663.2 12667.4 12691.0 8375.5 8415.5 8467.0 8487.1 8557.5 3240.9 3251.1 3333.6 3334.5 3393.1 1022.3 1102.3 1205.4 1211.9 1216.6 33622.7 34023.7 34087.1 34342.0 34594.1 1195.5 1232.0 1236.5 1263.0 1301.6 17667.2 17699.2 17731.0 17810.0 17932.3 557535.0 563036.0 563239.0 565060.0 566214.0 40113.2 41069.4 41087.0 41137.0 41294.8 1366.8 1378.1 1383.1 1398.2 1404.4 31524.8 33376.2 33898.5 33923.0 33994.0 52696.2 53285.0 53325.2 53414.5 53566.7 440820.0 443763.0 449224.0 449482.0 449942.0 28493.3 28701.3 28703.7 28805.3 29002.7 50293.0 50810.2 52024.2 54425.5 55399.4 42998.8 45449.5 46265.3 47890.0 48499.3 46563.5 46768.9 47201.0 47480.0 47550.0 39820.0 45527.0 46013.8 47803.8 48952.8 42325.4 46336.8 46718.3 46931.5 47154.8 35546.8 36270.6 36730.3 37009.6 37107.6 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#2] jquery.html Cycles:180 Average:28023.88 Median:12880.70 stddev:76341.81 (592.7%) stddev-sans-first:76527.77 05:58:46 INFO - PROCESS | 6416 | Values: 392.4 397.4 398.1 404.6 418.2 18132.7 19269.8 19567.4 19597.7 19787.3 17955.7 18400.0 18612.4 19297.8 19300.2 5701.7 5741.7 5750.9 5790.1 5955.5 5768.8 5788.3 5807.6 5840.1 5847.0 5710.3 5758.1 5777.7 5809.2 5830.9 5756.1 5758.0 5807.2 5807.7 5845.4 5036.7 5145.5 5173.7 5185.0 5196.0 19455.3 22824.7 23426.4 23535.8 23717.9 2335.0 2348.2 2478.1 2537.3 2909.7 14266.4 14289.1 14456.7 14603.2 14834.7 1932.9 1986.5 1996.9 2000.8 2012.9 66362.7 81310.6 82399.6 82541.6 83431.6 10180.5 10524.8 10775.0 10823.8 10955.9 14473.6 14606.2 14615.0 14693.6 14713.6 7819.3 7940.9 8246.5 8320.5 8609.5 8240.3 8280.8 8367.6 8486.2 8573.7 6596.9 6622.1 6715.5 6774.6 6799.6 1925.2 1934.7 1937.6 1952.1 1965.0 955.1 973.1 1074.6 1109.0 1140.4 19813.2 20292.3 20355.5 20571.4 20707.3 1059.2 1069.1 1083.1 1104.9 1128.3 11105.8 11654.4 11670.5 11687.0 11694.3 454192.0 464731.0 465009.0 467142.0 469320.0 82150.6 83239.6 83477.2 83537.0 84128.6 1048.4 1064.6 1070.5 1088.9 1093.0 17581.6 17918.9 17940.8 18113.7 18244.0 36285.0 37458.0 38967.2 39587.0 40596.4 51482.0 53193.7 53650.2 54310.0 55064.0 7583.1 8604.6 8707.3 8899.5 8901.2 11876.5 13651.2 13991.7 14036.0 14111.6 11917.3 12433.9 12450.0 12457.1 12486.1 11876.8 11898.0 12019.7 12163.8 12374.3 11566.9 11796.9 12103.5 12439.3 12803.7 7755.0 8026.4 8166.8 8175.5 8182.2 11164.7 11339.1 11605.7 11818.0 11995.9 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#3] mootools.html Cycles:180 Average:5981.99 Median:2453.51 stddev:3450.09 (140.6%) stddev-sans-first:3443.59 05:58:46 INFO - PROCESS | 6416 | Values: 1535.2 1540.6 1703.7 1804.5 1836.9 8123.7 8815.6 8890.9 9374.9 9389.6 8884.4 9242.5 9309.1 9332.3 9336.4 2378.8 2396.0 2400.2 2411.8 2413.1 2330.3 2331.7 2378.7 2382.1 2393.7 2320.7 2346.3 2378.5 2448.3 2454.5 2325.5 2336.1 2338.0 2345.6 2377.7 2354.2 2355.2 2356.0 2358.1 2391.2 9183.8 9220.3 9234.2 9239.0 9247.9 5282.9 5359.4 5378.3 5412.6 5412.8 3420.9 3439.8 3503.2 3614.5 3616.4 1133.2 1170.6 1189.0 1215.4 1232.6 12632.5 12734.3 12749.6 12772.4 12776.2 4718.2 4789.1 4849.7 4886.3 4900.8 10067.9 10075.7 10077.7 10082.8 10085.6 5335.3 5382.1 5392.8 5431.1 5520.8 4593.8 4919.7 5048.2 5057.9 5065.0 3930.4 3957.2 3961.7 4055.9 4094.8 1188.4 1199.8 1203.0 1205.8 1232.9 879.3 957.1 1033.8 1042.8 1045.9 6220.9 6263.8 6277.0 6391.2 6397.7 453.6 473.1 1048.7 1121.3 1127.1 4145.7 4326.4 4370.9 4411.1 4453.4 11330.3 11642.9 11760.1 11791.8 11842.3 11237.3 11646.7 11657.0 11664.7 11677.9 8529.3 8573.2 8609.8 8671.7 8694.4 5393.4 5405.0 5406.4 5421.4 5493.5 10550.7 10656.1 10669.7 10671.2 10748.6 10623.2 10853.3 10885.0 11025.2 11073.8 7007.2 7298.4 7473.3 7754.2 7909.3 8767.6 8818.6 8822.0 8838.6 8889.6 7567.6 7819.1 7887.0 7939.1 7953.6 7681.6 7729.8 7798.0 7819.1 7965.1 7231.2 7260.9 7353.2 7387.8 7396.6 5199.2 5260.8 5313.9 5353.3 5375.2 5050.0 5114.7 5247.5 5383.9 5539.2 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#4] prototype.html Cycles:180 Average:4881.99 Median:5489.81 stddev:1457.48 (26.5%) stddev-sans-first:1420.61 05:58:46 INFO - PROCESS | 6416 | Values: 310.8 317.7 320.4 336.6 340.6 5447.8 5491.9 5580.8 5682.8 5703.1 5627.6 5628.9 5629.0 5636.4 5650.9 4331.0 4354.7 4366.6 4372.2 4382.7 4107.9 4360.2 4363.6 4396.9 4413.6 4284.7 4296.4 4304.6 4305.9 4311.5 4290.5 4304.2 4308.6 4331.7 4334.8 3590.0 3764.4 3769.1 3790.8 3794.8 5403.3 5430.2 5434.9 5451.9 5487.7 4872.3 4898.6 4937.6 4941.1 4955.9 5434.9 5847.3 5856.6 5924.3 5954.3 4088.7 4096.4 4126.9 4131.6 4164.6 6042.6 6054.5 6129.8 6136.0 6140.9 4125.5 4202.7 4218.2 4257.5 4259.3 4220.2 4222.6 4238.2 4242.4 4290.3 4825.3 4896.5 4932.0 4939.8 4956.0 5723.3 5839.0 5876.4 5979.3 6013.2 1464.8 1468.1 1481.3 1483.3 1490.4 895.9 933.0 939.6 945.0 949.8 4985.9 5036.7 5045.5 5049.7 5165.6 5303.3 5339.8 5351.0 5444.1 5453.4 5009.8 5088.6 5137.6 5270.5 5762.9 3203.0 3204.3 3205.7 3225.6 3243.8 6040.3 6238.9 6257.2 6288.9 6290.1 6098.3 6138.5 6141.0 6150.3 6168.7 6252.0 6267.2 6276.3 6280.7 6301.5 5765.5 5913.7 5967.7 6034.5 6037.8 5919.8 5943.6 5978.9 5998.4 6011.3 6033.0 6266.8 6290.3 6329.0 6334.3 4151.9 4158.4 4160.6 4161.5 4170.7 6053.7 6057.5 6059.8 6066.2 6068.3 5530.4 5843.9 5849.5 5880.0 5926.6 5910.9 5916.3 5925.8 5928.2 5936.6 5572.8 5778.7 5799.5 5823.0 5842.6 5815.7 5854.7 5882.7 5909.2 5928.8 5792.0 5810.3 5813.9 5819.8 5827.5 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - PROCESS | 6416 | [#5] yui.html Cycles:180 Average:16168.74 Median:4698.68 stddev:19782.53 (421.0%) stddev-sans-first:19804.13 05:58:46 INFO - PROCESS | 6416 | Values: 748.5 754.3 764.0 810.6 848.2 12892.2 14258.3 14869.6 15390.7 15793.0 14693.6 15115.7 15159.8 15205.2 15281.2 799.4 806.9 807.6 807.7 811.6 822.6 822.7 822.9 824.9 825.0 859.6 860.4 861.2 863.5 865.7 851.3 853.8 860.4 861.1 865.3 612.0 616.9 617.1 623.5 633.2 13378.5 13399.7 13485.2 13577.6 13587.9 13567.9 14052.4 14059.7 14086.9 14294.0 10445.5 10507.6 10768.9 10843.5 10861.5 3864.8 3897.6 3996.8 4030.9 4069.9 61662.7 63386.0 63600.0 63909.0 63992.4 10585.6 10651.9 10732.8 10793.7 11142.6 19438.7 19540.6 19548.2 19579.0 19582.0 7721.1 7796.5 7939.0 7952.4 8255.0 4511.8 4563.3 4662.8 4684.4 4713.0 3399.7 3476.3 3488.1 3488.3 3491.6 612.4 623.1 625.7 628.3 635.3 735.4 746.7 752.5 758.7 792.7 9411.9 9419.3 9612.9 9664.0 9675.9 564.3 651.8 679.6 689.7 695.7 4534.2 4753.0 4755.4 4761.9 4775.5 67018.0 70421.3 72174.3 72819.3 73134.0 63941.4 64210.7 64284.0 65741.0 66061.0 56500.7 56737.7 57119.4 57192.7 57860.0 9035.9 9187.0 9189.8 9193.8 9240.8 39016.6 39236.0 39408.6 39577.4 39945.8 46689.0 47989.0 49766.0 51434.0 51872.1 12050.8 12163.3 12238.8 12512.7 12614.6 13441.9 13793.4 14227.5 14410.9 14485.8 13059.9 13077.1 13452.9 13521.0 13813.8 12995.2 13051.7 13259.3 13406.9 14244.2 12390.4 12558.9 13261.1 13622.2 13638.0 10434.7 10460.3 10603.8 10757.8 10838.2 11309.2 11311.3 11323.0 11404.7 11578.8 05:58:46 INFO - PROCESS | 6416 | -------- Summary: end -------- 05:58:46 INFO - PROCESS | 6416 | 05:58:46 INFO - TEST-INFO | 6416: exit 0 05:58:46 INFO - TEST-OK | dromaeo_css | took 1110090ms 05:58:46 INFO - TEST-START | kraken 05:58:46 INFO - operating with platform_type : linux_ 05:58:46 INFO - Initialising browser for kraken test... 05:58:46 INFO - TEST-INFO | started process 6644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgI5vd4/profile http://localhost:50209/getInfo.html) 05:58:50 INFO - PROCESS | 6644 | 05:58:50 INFO - PROCESS | 6644 | (process:6710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:51 INFO - PROCESS | 6644 | __metrics Screen width/height:1600/1200 05:58:51 INFO - PROCESS | 6644 | colorDepth:24 05:58:51 INFO - PROCESS | 6644 | Browser inner width/height: 1024/697 05:58:51 INFO - PROCESS | 6644 | __metrics 05:58:51 ERROR - PROCESS | 6644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:58:52 INFO - TEST-INFO | 6644: exit 0 05:58:52 INFO - Browser initialized. 05:58:52 INFO - Running cycle 1/1 for kraken test... 05:58:52 INFO - TEST-INFO | started process 6761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgI5vd4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:54 INFO - PROCESS | 6761 | 05:58:54 INFO - PROCESS | 6761 | (process:6823): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:04 INFO - PROCESS | 6761 | RSS: Main: 166252544 05:59:04 INFO - PROCESS | 6761 | 05:59:07 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50209/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:08 INFO - PROCESS | 6761 | RSS: Main: 171220992 05:59:08 INFO - PROCESS | 6761 | 05:59:10 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50209/tests/kraken/driver.html?testName=audio-dft) 05:59:11 INFO - PROCESS | 6761 | RSS: Main: 171319296 05:59:11 INFO - PROCESS | 6761 | 05:59:14 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50209/tests/kraken/driver.html?testName=audio-fft) 05:59:14 INFO - PROCESS | 6761 | RSS: Main: 165789696 05:59:14 INFO - PROCESS | 6761 | 05:59:17 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50209/tests/kraken/driver.html?testName=audio-oscillator) 05:59:17 INFO - PROCESS | 6761 | RSS: Main: 166395904 05:59:17 INFO - PROCESS | 6761 | 05:59:19 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:20 INFO - PROCESS | 6761 | RSS: Main: 166400000 05:59:20 INFO - PROCESS | 6761 | 05:59:23 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50209/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:24 INFO - PROCESS | 6761 | RSS: Main: 166121472 05:59:24 INFO - PROCESS | 6761 | 05:59:27 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50209/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:28 INFO - PROCESS | 6761 | RSS: Main: 165216256 05:59:28 INFO - PROCESS | 6761 | 05:59:30 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50209/tests/kraken/driver.html?testName=json-parse-financial) 05:59:31 INFO - PROCESS | 6761 | RSS: Main: 165597184 05:59:31 INFO - PROCESS | 6761 | 05:59:33 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:33 INFO - PROCESS | 6761 | RSS: Main: 166191104 05:59:33 INFO - PROCESS | 6761 | 05:59:35 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:36 INFO - PROCESS | 6761 | RSS: Main: 166350848 05:59:36 INFO - PROCESS | 6761 | 05:59:38 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:39 INFO - PROCESS | 6761 | RSS: Main: 166612992 05:59:39 INFO - PROCESS | 6761 | 05:59:41 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:42 INFO - PROCESS | 6761 | RSS: Main: 166334464 05:59:42 INFO - PROCESS | 6761 | 05:59:44 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:45 INFO - PROCESS | 6761 | RSS: Main: 166383616 05:59:45 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | Cycle 1(1): loaded http://localhost:50209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50209/tests/kraken/driver.html?testName=ai-astar) 05:59:47 INFO - PROCESS | 6761 | RSS: Main: 168079360 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | __start_tp_report 05:59:47 INFO - PROCESS | 6761 | _x_x_mozilla_page_load 05:59:47 INFO - PROCESS | 6761 | _x_x_mozilla_page_load_details 05:59:47 INFO - PROCESS | 6761 | |i|pagename|runs| 05:59:47 INFO - PROCESS | 6761 | |0;ai-astar;113;107;111;111;111;113;111;111;111;112 05:59:47 INFO - PROCESS | 6761 | |1;audio-beat-detection;156;132;162;177;128;153;152;145;185;128 05:59:47 INFO - PROCESS | 6761 | |2;audio-dft;163;163;163;162;163;170;167;164;160;163 05:59:47 INFO - PROCESS | 6761 | |3;audio-fft;75;74;76;163;75;74;74;75;183;75 05:59:47 INFO - PROCESS | 6761 | |4;audio-oscillator;84;83;146;83;85;84;141;84;84;140 05:59:47 INFO - PROCESS | 6761 | |5;imaging-gaussian-blur;118;118;117;117;118;117;117;117;117;117 05:59:47 INFO - PROCESS | 6761 | |6;imaging-darkroom;147;149;147;147;148;147;147;148;148;146 05:59:47 INFO - PROCESS | 6761 | |7;imaging-desaturate;95;97;95;96;95;95;97;96;95;95 05:59:47 INFO - PROCESS | 6761 | |8;json-parse-financial;58;61;57;59;57;61;57;73;56;56 05:59:47 INFO - PROCESS | 6761 | |9;json-stringify-tinderbox;62;62;62;62;63;63;62;62;67;62 05:59:47 INFO - PROCESS | 6761 | |10;stanford-crypto-aes;79;79;81;80;81;86;81;80;82;80 05:59:47 INFO - PROCESS | 6761 | |11;stanford-crypto-ccm;130;124;129;120;119;131;123;121;171;125 05:59:47 INFO - PROCESS | 6761 | |12;stanford-crypto-pbkdf2;164;166;167;168;158;158;159;158;161;157 05:59:47 INFO - PROCESS | 6761 | |13;stanford-crypto-sha256-iterative;63;63;62;64;66;63;63;63;64;62 05:59:47 INFO - PROCESS | 6761 | __end_tp_report 05:59:47 INFO - PROCESS | 6761 | __start_cc_report 05:59:47 INFO - PROCESS | 6761 | _x_x_mozilla_cycle_collect,853 05:59:47 INFO - PROCESS | 6761 | __end_cc_report 05:59:47 INFO - PROCESS | 6761 | __startTimestamp1464267587461__endTimestamp 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | ------- Summary: start ------- 05:59:47 INFO - PROCESS | 6761 | Number of tests: 14 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.66 (1.5%) stddev-sans-first:1.62 05:59:47 INFO - PROCESS | 6761 | Values: 113.0 107.0 111.0 111.0 111.0 113.0 111.0 111.0 111.0 112.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.50 stddev:19.53 (12.6%) stddev-sans-first:20.65 05:59:47 INFO - PROCESS | 6761 | Values: 156.0 132.0 162.0 177.0 128.0 153.0 152.0 145.0 185.0 128.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.78 (1.7%) stddev-sans-first:2.93 05:59:47 INFO - PROCESS | 6761 | Values: 163.0 163.0 163.0 162.0 163.0 170.0 167.0 164.0 160.0 163.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.00 stddev:41.70 (55.6%) stddev-sans-first:43.63 05:59:47 INFO - PROCESS | 6761 | Values: 75.0 74.0 76.0 163.0 75.0 74.0 74.0 75.0 183.0 75.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.00 stddev:28.29 (33.7%) stddev-sans-first:29.30 05:59:47 INFO - PROCESS | 6761 | Values: 84.0 83.0 146.0 83.0 85.0 84.0 141.0 84.0 84.0 140.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:59:47 INFO - PROCESS | 6761 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 05:59:47 INFO - PROCESS | 6761 | Values: 147.0 149.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 146.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 05:59:47 INFO - PROCESS | 6761 | Values: 95.0 97.0 95.0 96.0 95.0 95.0 97.0 96.0 95.0 95.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.50 stddev:5.08 (8.7%) stddev-sans-first:5.36 05:59:47 INFO - PROCESS | 6761 | Values: 58.0 61.0 57.0 59.0 57.0 61.0 57.0 73.0 56.0 56.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.00 stddev:1.57 (2.5%) stddev-sans-first:1.64 05:59:47 INFO - PROCESS | 6761 | Values: 62.0 62.0 62.0 62.0 63.0 63.0 62.0 62.0 67.0 62.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.02 (2.5%) stddev-sans-first:2.03 05:59:47 INFO - PROCESS | 6761 | Values: 79.0 79.0 81.0 80.0 81.0 86.0 81.0 80.0 82.0 80.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:127.00 stddev:15.24 (12.0%) stddev-sans-first:16.16 05:59:47 INFO - PROCESS | 6761 | Values: 130.0 124.0 129.0 120.0 119.0 131.0 123.0 121.0 171.0 125.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.50 stddev:4.25 (2.6%) stddev-sans-first:4.42 05:59:47 INFO - PROCESS | 6761 | Values: 164.0 166.0 167.0 168.0 158.0 158.0 159.0 158.0 161.0 157.0 05:59:47 INFO - PROCESS | 6761 | 05:59:47 INFO - PROCESS | 6761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 05:59:47 INFO - PROCESS | 6761 | Values: 63.0 63.0 62.0 64.0 66.0 63.0 63.0 63.0 64.0 62.0 05:59:47 INFO - PROCESS | 6761 | -------- Summary: end -------- 05:59:47 INFO - PROCESS | 6761 | 05:59:48 INFO - TEST-INFO | 6761: exit 0 05:59:48 INFO - TEST-OK | kraken | took 61484ms 05:59:48 INFO - SUITE-END | took 1171s 05:59:48 INFO - Completed test suite (00:19:31) 05:59:48 INFO - javascript benchmark 05:59:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.2678012993665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.7655675824317, 3145.103645461044, 3164.1614972032417, 3174.206448387903, 3184.2357834119803, 5374.865628359293, 5503.174523821429, 5528.143137813645, 5545.77816887325, 5597.188407680884, 5402.729863506828, 5445.918311225325, 5470.835874923759, 5480.588955828319, 5566.304211973493, 4935.531124543163, 4971.105201063798, 5005.549500544968, 5017.799288028475, 5090.516400941905, 411.9036223981418, 4966.528179822929, 5045.091883460976, 5073.112205364065, 5097.847064588068, 4905.117078925792, 4964.007198560303, 4965.131102057144, 5009.674371165881, 5032.547070763649, 5035.521625445577, 5035.6978581284875, 5039.874003149914, 5064.3163172971545, 5089.847304580869, 4952.158133117343, 4960.057589058068, 4965.82619608312, 5021.5229553192385, 5024.171011783052, 5389.622726409114, 5424.728763561806, 5468.589855760833, 5492.47821456961, 5493.23094766733, 5913.172155898178, 5946.910796338058, 5947.910781338283, 5955.166276721263, 5963.4334738199805, 5816.040353341736, 5872.677002764846, 5884.293884733816, 5922.378150294243, 5949.791757288517, 5527.695976721278, 5554.638948468377, 5555.805546805883, 5567.638103523258, 5586.720663966786, 5888.587798854039, 6077.726502307407, 6089.1779609753, 6099.817005489843, 6114.11345354921, 5790.420957904176, 5805.651660900359, 5858.238429004202, 5879.294484661782, 5900.734466948998, 5960.0, 5974.253218347707, 5974.790882319098, 5975.073863551156, 5980.282366116007, 5702.942970570324, 5864.296284445893, 5874.94125058744, 5877.353491115974, 5890.911636325459, 5941.970290148522, 5973.104034394875, 5973.522118230618, 5975.611585246945, 6025.638461692312, 4491.0, 4498.437695288089, 4506.076254367847, 4526.637868970474, 4560.110778398247, 3902.590228026073, 3950.6246906543834, 3967.900802479961, 4017.678585713136, 4046.2716710991717, 5565.165225216169, 5633.9858825411, 5708.600397972102, 5721.056025755787, 5737.3688894221605, 5969.492593129546, 5995.790147344822, 6010.158577799111, 6015.4586087252355, 6023.488003519662, 5551.084071128219, 5671.773129074791, 5702.942970570241, 5721.828345149652, 5746.770129194869, 4977.178765503724, 4980.252962055721, 4982.377202849644, 4985.825496107619, 5013.097642424399, 6151.630902145886, 6176.227971503562, 6189.6286222826775, 6192.504599632019, 6195.721192546346, 5725.685087320154, 5921.082232254007, 5953.434423729739, 5962.940370596412, 5983.9401605983385, 6122.663253521099, 6159.692015399301, 6172.969135154295, 6200.782972595937, 6208.658523781235, 5835.066389377679, 5866.120081987565, 5894.292684877671, 5896.321922978741, 5910.852228694317, 5888.116782482491, 5922.851928701817, 5929.6145750526075, 6008.218931538872, 6039.48664363534, 5826.067829147316, 5829.446202610745, 5844.26946631671, 5862.765489380377, 5880.8235752927485, 5680.176374425768, 5855.531557475307, 5856.648601083949, 5863.0, 5870.090136028923, 5679.943200567942, 5736.569757268138, 5741.25363702716, 5763.884722305615, 5783.248177736868, 5797.623154495113, 5810.012297909281, 5851.970740146272, 5874.03078492044, 5874.118882167709, 5521.503064724034, 5656.971715141398, 5726.226959360433, 5770.394108618702, 5794.420557944172], "value": 5424.842108606635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.7110630238033, 628.7642134199675, 649.619972316195, 670.1355251725274, 675.1864003875331, 40587.59412405875, 44190.999999999956, 44210.0, 44285.7785711071, 44511.0, 44679.77660111703, 45482.090358192814, 45666.0, 45721.0, 45818.0, 8712.825743485142, 8902.821943561157, 8907.955460222689, 8910.50992195429, 8913.108689131068, 8797.560121993874, 8836.734897953073, 8849.07084756101, 8854.601542930584, 8873.068327825582, 8871.334649901251, 8881.822363552725, 8918.687845925393, 8924.062973387798, 8992.77518062047, 8795.296376289882, 8883.0, 8895.154960278764, 8895.644174233023, 8967.103289671046, 8773.517456539888, 8820.117988201193, 8839.558022098934, 8869.246114080246, 8877.0, 32951.6704832951, 42257.78871105625, 42439.57560424387, 42745.145097097884, 42934.78532607317, 3355.6644335566248, 3361.226917808893, 3473.930521389558, 3550.9822450887837, 3611.9097022574383, 32058.0, 32470.675293247237, 32595.0, 32723.18192045194, 33059.0, 3862.6009111981557, 3898.3762597984187, 3948.6643635291034, 3995.0, 4015.3976903464422, 307039.0, 309539.0, 309763.0, 310163.0, 311894.0, 34818.129546761535, 35203.4719479208, 35576.466353004726, 36048.81975590105, 36091.097722556624, 37151.25697486035, 37408.0, 37448.812755936044, 37499.625003749614, 37551.81224093862, 15335.693286134216, 15504.922475387777, 15564.610884727746, 15597.610059748597, 15626.140562269184, 12522.624321270376, 12601.936990315173, 12663.240205587694, 12667.36663166838, 12691.0, 8375.539345335943, 8415.537145456936, 8466.957665211634, 8487.10885357041, 8557.529335886586, 3240.8541615627355, 3251.1059458648588, 3333.6332103837312, 3334.4664853623303, 3393.100828280508, 1022.3405903192399, 1102.3000394749392, 1205.421397729095, 1211.9091068169923, 1216.6410908781754, 33622.663773362445, 34023.659763402546, 34087.147821304665, 34342.0, 34594.13514662103, 1195.5337418406828, 1231.969200769988, 1236.536298887917, 1262.958059600833, 1301.5769874790542, 17667.20497577612, 17699.20353584092, 17731.0, 17810.0, 17932.282708691506, 557535.0, 563036.0, 563239.0, 565060.0, 566214.0, 40113.1977360457, 41069.38395924064, 41087.0, 41136.971575710246, 41294.79352603278, 1366.760816857066, 1378.1111183286723, 1383.100984360174, 1398.2100113435877, 1404.3527949814672, 31524.842375787975, 33376.1655958603, 33898.49152262669, 33923.0, 33994.0, 52696.209556857444, 53285.0, 53325.200121998976, 53414.4658553425, 53566.732166338916, 440820.0, 443763.0, 449224.0, 449482.0, 449942.0, 28493.287667807643, 28701.28246793847, 28703.712962870104, 28805.27986800347, 29002.7099729, 50293.0, 50810.23784643159, 52024.21963670472, 54425.455745442036, 55399.44600553943, 42998.785006074766, 45449.545504544534, 46265.3060204104, 47890.0, 48499.27251091166, 46563.53436465727, 46768.89702662975, 47201.0, 47480.0, 47550.0, 39820.0, 45527.0, 46013.76993115013, 47803.76098119487, 48952.75523622359, 42325.36511952385, 46336.76831615955, 46718.299225512324, 46931.53068469271, 47154.764226178646, 35546.82619408215, 36270.63729362673, 36730.26539469142, 37009.62990370062, 37107.6289237115], "value": 19205.12589055159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.39962856829044, 397.40389415876183, 398.1042654028436, 404.6216787303871, 418.2492426095159, 18132.728009079874, 19269.807301926976, 19567.41297761066, 19597.70603440948, 19787.307444239454, 17955.73066404005, 18400.0, 18612.441626751184, 19297.807021929777, 19300.227990880347, 5701.74342154602, 5741.741621627016, 5750.942490575104, 5790.131480277971, 5955.523558115362, 5768.82693519193, 5788.305403351604, 5807.593468457209, 5840.0947853082625, 5846.970765146169, 5710.2862142232225, 5758.136279558058, 5777.653340799566, 5809.157672137538, 5830.912536311958, 5756.107803290497, 5757.9712101439645, 5807.2160258365, 5807.738651760681, 5845.415458454163, 5036.722980236085, 5145.536901678829, 5173.663711858717, 5184.974075129638, 5196.0, 19455.319063832838, 22824.65763013556, 23426.414339641477, 23535.764102410245, 23717.88141059301, 2334.976650233493, 2348.189874493297, 2478.1202673051166, 2537.3402915241986, 2909.6653884803095, 14266.429342826275, 14289.142651440947, 14456.71086578273, 14603.196824174665, 14834.703305933821, 1932.9226830926887, 1986.5430950881378, 1996.8602197846012, 2000.8499362547868, 2012.8691635043676, 66362.66818665924, 81310.59344703238, 82399.58800205961, 82541.58729206315, 83431.582842086, 10180.541875615467, 10524.842127368096, 10775.0, 10823.783524329468, 10955.945220273848, 14473.638159046108, 14606.196659183846, 14615.0, 14693.55919322422, 14713.55859324222, 7819.335356494648, 7940.880886786703, 8246.463979841292, 8320.459170153921, 8609.526476043879, 8240.258376746122, 8280.751577452686, 8367.58162091905, 8486.236238738544, 8573.699920502753, 6596.86806263872, 6622.072909792633, 6715.529912906148, 6774.593524388552, 6799.558028728117, 1925.210663627906, 1934.6517626827306, 1937.6318499485053, 1952.1215453045902, 1964.9607007859763, 955.1499165742356, 973.090160699748, 1074.6023971130576, 1109.0074383426788, 1140.3670962615827, 19813.20747170097, 20292.347377471902, 20355.491112722004, 20571.38285851427, 20707.27524536634, 1059.195011791029, 1069.1446842525947, 1083.0685610375072, 1104.861892263467, 1128.2948157401624, 11105.777884442266, 11654.359010254348, 11670.474828632732, 11687.0, 11694.2983420995, 454192.0, 464731.0, 465009.0, 467142.0, 469320.0, 82150.58924705339, 83239.58380208182, 83477.16522834694, 83537.0, 84128.57935710404, 1048.4233671480656, 1064.5794911010107, 1070.4808168038496, 1088.9292196007234, 1092.9890701093045, 17581.648367032332, 17918.91040544789, 17940.820591793916, 18113.728294075863, 18244.0, 36285.0, 37458.0, 38967.22065558616, 39586.99999999885, 40596.3910541348, 51482.0, 53193.73403132959, 53650.19524707211, 54310.0, 55064.0, 7583.090029196532, 8604.569771511524, 8707.346948978726, 8899.510526920823, 8901.198892099743, 11876.524939002344, 13651.249181295125, 13991.720165596835, 14036.0, 14111.647208819862, 11917.284962902253, 12433.937830311152, 12450.003999679822, 12457.065720071212, 12486.063545234325, 11876.821847672465, 11898.0, 12019.699507512381, 12163.817542737042, 12374.319412432042, 11566.94216528912, 11796.882031179579, 12103.455344509342, 12439.253644781342, 12803.679908002374, 7754.9530813341735, 8026.43814932949, 8166.836663266583, 8175.509469431853, 8182.22268884455, 11164.720881978015, 11339.149563782914, 11605.6518304451, 11818.0, 11995.940020299842], "value": 9435.814695800995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.1556643845881, 1540.5532395605273, 1703.6507515959229, 1804.4586624012793, 1836.9173387197575, 8123.715669951553, 8815.603297851596, 8890.911090889089, 9374.85937710935, 9389.577469013886, 8884.422512536697, 9242.537873106352, 9309.069093090688, 9332.346735728503, 9336.393134446256, 2378.7621237876247, 2396.0, 2400.243923164198, 2411.807055435561, 2413.1312727418203, 2330.33585428153, 2331.708536432946, 2378.7383387827413, 2382.059086660768, 2393.7366889642126, 2320.6867072945106, 2346.2843832631042, 2378.54807586558, 2448.289995901195, 2454.460018795862, 2325.4883925536355, 2336.0538981712434, 2337.9532409351805, 2345.554344674515, 2377.7265614454386, 2354.176038386551, 2355.1521452277166, 2356.0340260493285, 2358.0803486640225, 2391.175044609607, 9183.770405739842, 9220.262379009662, 9234.215091717213, 9239.0, 9247.861282080774, 5282.947170528322, 5359.356877174725, 5378.327709036371, 5412.56699464042, 5412.810551630674, 3420.863165473378, 3439.810810405452, 3503.24680193757, 3614.4939708440575, 3616.4032934565766, 1133.1784456269222, 1170.6195486466931, 1189.02499950041, 1215.398377802993, 1232.5686009896554, 12632.49470021198, 12734.299613521252, 12749.617511474671, 12772.425240864277, 12776.169548979287, 4718.243349598566, 4789.137955168034, 4849.660523763303, 4886.315915771795, 4900.754962251873, 10067.949660251652, 10075.697729068139, 10077.69766906994, 10082.848757268646, 10085.647002354883, 5335.253064570963, 5382.138857782736, 5392.78428862849, 5431.076716958048, 5520.779168833202, 4593.839215627437, 4919.729414882144, 5048.192289233705, 5057.898842023213, 5065.037642847848, 3930.3514920037874, 3957.1887763008513, 3961.6830653547645, 4055.8986025349013, 4094.774787386663, 1188.3582865252667, 1199.8320235167084, 1203.0195390756505, 1205.8311836342918, 1232.9013678905667, 879.2877769007125, 957.095544710256, 1033.788073444942, 1042.8122937871103, 1045.8535804987307, 6220.911340515482, 6263.812085637438, 6276.968615156895, 6391.169148010822, 6397.744090236339, 453.59629929362893, 473.091664005111, 1048.7168464514539, 1121.2767764791827, 1127.0701671121358, 4145.66834653233, 4326.3510473428605, 4370.934435983399, 4411.117776444724, 4453.421055262795, 11330.320180789178, 11642.94178529102, 11760.117991150526, 11791.764164716658, 11842.348670823187, 11237.269577477438, 11646.650600481998, 11657.0, 11664.708382290512, 11677.941610291895, 8529.294141171791, 8573.18554737299, 8609.827803443895, 8671.696490622924, 8694.434861733967, 5393.352797664148, 5405.00119645837, 5406.432324605859, 5421.403645598902, 5493.505584497414, 10550.683479495627, 10656.094231990057, 10669.679909602724, 10671.199660025373, 10748.62379816734, 10623.150147988297, 10853.294535855144, 10885.0, 11025.228234023542, 11073.833892491459, 7007.159140902921, 7298.379637730853, 7473.327400533978, 7754.224577542201, 7909.288164065261, 8767.60545775429, 8818.647254110021, 8821.985471670583, 8838.64645414202, 8889.64441422336, 7567.583782891774, 7819.100803407681, 7887.0, 7939.126696063544, 7953.6023198840985, 7681.577513236825, 7729.768106956801, 7798.025246844145, 7819.0617125945255, 7965.123836378109, 7231.16841563227, 7260.854782904418, 7353.154387245535, 7387.7783666490095, 7396.593187374746, 5199.220116982483, 5260.8158714446345, 5313.893722125613, 5353.304070470814, 5375.19372094189, 5049.974750126373, 5114.71869047206, 5247.475252474722, 5383.919241211307, 5539.169124631177], "value": 4755.734536045467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.82593747501403, 317.72675499070795, 320.40085040973366, 336.6498841205147, 340.55387442450376, 5447.809326673567, 5491.9290738305945, 5580.804671836487, 5682.801101961432, 5703.0589952657765, 5627.577931655122, 5628.859278518039, 5628.971855140719, 5636.379998200205, 5650.858728531789, 4330.956690433095, 4354.651627869779, 4366.628836548897, 4372.2130016597, 4382.737035777847, 4107.870335657703, 4360.21516127097, 4363.607275345218, 4396.912061758763, 4413.6027757501815, 4284.657227421814, 4296.355546667994, 4304.591063848945, 4305.892352691192, 4311.547287534795, 4290.485141783006, 4304.182205380967, 4308.633766129883, 4331.718438301532, 4334.783260836962, 3589.964100358989, 3764.3788774852114, 3769.1142581493327, 3790.8104594770152, 3794.848206071754, 5403.297571315743, 5430.212619170237, 5434.945650543484, 5451.863703407407, 5487.6981766002855, 4872.317875497433, 4898.632602554787, 4937.629677774181, 4941.135301322291, 4955.900881982377, 5434.91847622286, 5847.2983242010805, 5856.6031701612965, 5924.318703349084, 5954.315253745788, 4088.6524645405175, 4096.40602112692, 4126.926998980287, 4131.628153466172, 4164.56272091429, 6042.57701960863, 6054.485368743618, 6129.846753831145, 6136.0, 6140.907886381708, 4125.50493940723, 4202.739178246514, 4218.198542276958, 4257.488591550017, 4259.254630439661, 4220.2192594370135, 4222.577742225752, 4238.237117318912, 4242.384854196124, 4290.313549832012, 4825.30033145192, 4896.46138924718, 4931.9753401232765, 4939.75301234944, 4955.950440495549, 5723.313202415654, 5839.0, 5876.41235876409, 5979.252593425822, 6013.188219590299, 1464.7509923313062, 1468.1411374345914, 1481.3185934470048, 1483.3325003748357, 1490.3814916809404, 895.9059298773535, 932.9813403731887, 939.6006697153682, 945.0313428735464, 949.8222204466412, 4985.875353116128, 5036.697798132123, 5045.495450454999, 5049.747512624354, 5165.560927321219, 5303.310569626001, 5339.759710813023, 5351.0, 5444.128939369761, 5453.391249581383, 5009.793732011515, 5088.567471764867, 5137.563307118937, 5270.549194624518, 5762.9135562966585, 3202.967970320267, 3204.2630195055267, 3205.7275131613605, 3225.59680039995, 3243.8053716777067, 6040.275166979903, 6238.906416403757, 6257.249130104326, 6288.874222515616, 6290.087937249074, 6098.26820781509, 6138.5396095292135, 6141.0, 6150.261968563712, 6168.722407491674, 6251.999040460513, 6267.151190398843, 6276.309605943434, 6280.685965701788, 6301.52738544611, 5765.4811067004175, 5913.733881975236, 5967.7016149191495, 6034.487068599218, 6037.788677396446, 5919.822405327847, 5943.583949123693, 5978.880422391441, 5998.400159984141, 6011.278646562266, 6033.0, 6266.843328916631, 6290.2766181889665, 6328.968355158379, 6334.334894835976, 4151.916961660811, 4158.417821505052, 4160.628441788152, 4161.52142503616, 4170.72890262132, 6053.72985130576, 6057.545684073624, 6059.757609695563, 6066.241719785027, 6068.271807383142, 5530.391656917816, 5843.853903652443, 5849.473547380756, 5880.0, 5926.644401335933, 5910.940890591039, 5916.290045194432, 5925.792597259076, 5928.199693041557, 5936.554758393051, 5572.841731095584, 5778.653280803165, 5799.536037116936, 5823.0, 5842.591018628656, 5815.709214539172, 5854.677992710442, 5882.735276912464, 5909.172715819703, 5928.828076978795, 5792.017111187826, 5810.273715785527, 5813.854653633693, 5819.79630712923, 5827.475527202572], "value": 4408.238488665651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.4872862089466, 754.3098065270275, 763.9618019099047, 810.6473683947481, 848.2196379331017, 12892.226466411998, 14258.287085645728, 14869.553913382602, 15390.69218615627, 15792.97345672532, 14693.632659183526, 15115.6976860463, 15159.848401515981, 15205.239738013082, 15281.2359382031, 799.360511590728, 806.899137607799, 807.6325272001254, 807.6890397197062, 811.6469335838899, 822.6092606012156, 822.7120507822274, 822.942394032415, 824.9133840946704, 825.0470706334194, 859.6002858670716, 860.4407135362002, 861.1732736572866, 863.4560227056945, 865.6623916672503, 851.3231980575457, 853.8463076646201, 860.3633311349619, 861.0657436681208, 865.2818160926416, 611.9816405507797, 616.8982117950533, 617.1113596421139, 623.4513628007325, 633.1673848888743, 13378.531751388655, 13399.732005359936, 13485.190888546718, 13577.59267221985, 13587.864121358758, 13567.86432135676, 14052.36764345607, 14059.718805623932, 14086.929565352108, 14294.0, 10445.477726113664, 10507.632232871812, 10768.892311076866, 10843.512041958053, 10861.511231994578, 3864.845406183749, 3897.61023897608, 3996.760194388346, 4030.858919937788, 4069.9389509157386, 61662.69168654173, 63386.0, 63600.0, 63909.0, 63992.360076399105, 10585.57657693699, 10651.946740266249, 10732.839007414896, 10793.67618971432, 11142.554297827995, 19438.70841937372, 19540.609187816164, 19548.218071277275, 19579.042095790308, 19582.0, 7721.073471183494, 7796.4932279401655, 7938.960305198552, 7952.357497873098, 8255.047863612243, 4511.774411279423, 4563.338315944169, 4662.836800711959, 4684.414448193976, 4712.95287047132, 3399.66003399663, 3476.252605689738, 3488.0582242794303, 3488.302339532104, 3491.6159222486012, 612.3967891626744, 623.1462895832739, 625.6965371794676, 628.2931701835436, 635.3170341882402, 735.3565630073685, 746.6565379925187, 752.5221484357363, 758.6737702787855, 792.6750032486768, 9411.858822117674, 9419.340646154704, 9612.855807162898, 9664.0, 9675.90324096764, 564.2777245126244, 651.7824812376892, 679.5650783498564, 689.7378995981595, 695.7321431248904, 4534.183846907522, 4752.952470475251, 4755.358026666425, 4761.880952976134, 4775.5224477552665, 67018.0, 70421.2957870425, 72174.27825721781, 72819.27180728124, 73134.0, 63941.36058639447, 64210.67894660497, 64284.0, 65741.0, 66061.0, 56500.717496413075, 56737.71631141818, 57119.42880571224, 57192.71403642955, 57860.0, 9035.864462032943, 9186.954065229631, 9189.816203676022, 9193.816123677356, 9240.768980775534, 39016.60983390243, 39236.0, 39408.60591394164, 39577.406338904366, 39945.80027099846, 46689.0, 47989.0, 49766.0, 51434.0, 51872.109591781526, 12050.75898482043, 12163.331016794162, 12238.816417753918, 12512.687182820502, 12614.55849045279, 13441.865581344062, 13793.412949711954, 14227.50203742864, 14410.855891440951, 14485.7827132591, 13059.934700326437, 13077.149985250928, 13452.865471345161, 13521.0, 13813.792793108312, 12995.155314904501, 13051.738965220453, 13259.337033148111, 13406.932965335502, 14244.216568088854, 12390.380480976095, 12558.937205313914, 13261.138026028277, 13622.182669039888, 13638.045336826326, 10434.68695939123, 10460.26778125524, 10603.840942386025, 10757.838632420677, 10838.187135964992, 11309.20835541537, 11311.321320720783, 11323.0, 11404.657860263873, 11578.826317605075], "value": 6977.514762079891, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 162.0, 177.0, 128.0, 153.0, 152.0, 145.0, 185.0, 128.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 163.0, 170.0, 167.0, 164.0, 160.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 163.0, 75.0, 74.0, 74.0, 75.0, 183.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 146.0, 83.0, 85.0, 84.0, 141.0, 84.0, 84.0, 140.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 57.0, 59.0, 57.0, 61.0, 57.0, 73.0, 56.0, 56.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 67.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 80.0, 81.0, 86.0, 81.0, 80.0, 82.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 129.0, 120.0, 119.0, 131.0, 123.0, 121.0, 171.0, 125.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 167.0, 168.0, 158.0, 158.0, 159.0, 158.0, 161.0, 157.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 66.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 63.3, "unit": "score"}]}]} 05:59:48 INFO - Return code: 0 05:59:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:59:48 ERROR - # TBPL SUCCESS # 05:59:48 INFO - Running post-action listener: _resource_record_post_action 05:59:48 INFO - ##### 05:59:48 INFO - ##### Finished run-tests step (success) 05:59:48 INFO - ##### 05:59:48 INFO - Running post-run listener: _resource_record_post_run 05:59:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 499712; Write bytes: 300716032; Read time: 52; Write time: 175404 05:59:48 INFO - TinderboxPrint: CPU usage
13.4% 05:59:48 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 52 05:59:48 INFO - TinderboxPrint: I/O write bytes / time
300,716,032 / 175,404 05:59:48 INFO - TinderboxPrint: CPU idle
8,219.1 (86.6%) 05:59:48 INFO - TinderboxPrint: CPU user
1,221.6 (12.9%) 05:59:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:59:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12926976; Read time: 0; Write time: 4980 05:59:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 499712; Write bytes: 287789056; Read time: 52; Write time: 170424 05:59:49 INFO - Running post-run listener: _upload_blobber_files 05:59:49 INFO - Blob upload gear active. 05:59:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:59:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:55 INFO - (blobuploader) - INFO - Done attempting. 05:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:09 INFO - (blobuploader) - INFO - Done attempting. 06:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:10 INFO - (blobuploader) - INFO - Done attempting. 06:00:10 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:10 INFO - Return code: 0 06:00:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43357b602e41c93ddabc3c670c5f524b2ea7af217dc0df2ffd4084562bed0b567aa87d231e7b2035fcddb89afe6333f46f024ad835145f545c398285512266f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a28384176c46342e62a26b99e8405928d62b644326007351bde0c0951c54b20dfbcde86793310b5c2a8cedd70b0f55ad9856970d640a0e7d71a5736ee1753adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029ed22c175eed1bc4f78ed69e91f39d1e7d9d258b42d9ae70e88192dc9996e5e0573ef028b0b72a4c51fdb834e2dd15c422ffaa351f39367925620d5acbbfe5"} 06:00:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:10 INFO - Contents: 06:00:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43357b602e41c93ddabc3c670c5f524b2ea7af217dc0df2ffd4084562bed0b567aa87d231e7b2035fcddb89afe6333f46f024ad835145f545c398285512266f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a28384176c46342e62a26b99e8405928d62b644326007351bde0c0951c54b20dfbcde86793310b5c2a8cedd70b0f55ad9856970d640a0e7d71a5736ee1753adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029ed22c175eed1bc4f78ed69e91f39d1e7d9d258b42d9ae70e88192dc9996e5e0573ef028b0b72a4c51fdb834e2dd15c422ffaa351f39367925620d5acbbfe5"} 06:00:10 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:10 INFO - Copying logs to upload dir... 06:00:10 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.061728 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-26 06:00:10.019601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 06:00:10.023054) ========= 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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 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/Firefox/sha512/43357b602e41c93ddabc3c670c5f524b2ea7af217dc0df2ffd4084562bed0b567aa87d231e7b2035fcddb89afe6333f46f024ad835145f545c398285512266f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a28384176c46342e62a26b99e8405928d62b644326007351bde0c0951c54b20dfbcde86793310b5c2a8cedd70b0f55ad9856970d640a0e7d71a5736ee1753adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029ed22c175eed1bc4f78ed69e91f39d1e7d9d258b42d9ae70e88192dc9996e5e0573ef028b0b72a4c51fdb834e2dd15c422ffaa351f39367925620d5acbbfe5"} build_url:https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/NJaNkhcPQ4euCmJgIiwXfA/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/Firefox/sha512/43357b602e41c93ddabc3c670c5f524b2ea7af217dc0df2ffd4084562bed0b567aa87d231e7b2035fcddb89afe6333f46f024ad835145f545c398285512266f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a28384176c46342e62a26b99e8405928d62b644326007351bde0c0951c54b20dfbcde86793310b5c2a8cedd70b0f55ad9856970d640a0e7d71a5736ee1753adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/029ed22c175eed1bc4f78ed69e91f39d1e7d9d258b42d9ae70e88192dc9996e5e0573ef028b0b72a4c51fdb834e2dd15c422ffaa351f39367925620d5acbbfe5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 06:00:10.048334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 06:00:10.048707) ========= 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=0e2a256762fed810e2f0f810000001b3-1464265613.425468-1562811149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 06:00:10.131133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 06:00:10.131457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 06:00:10.131808) ========= ========= Total master_lag: 0.18 =========