builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1464185233.92 results: success (0) buildid: 20160525043017 builduid: 736489b55a6c4ba6bdfd8331fc145635 revision: dd37cbc7e54337e7048e8aea6a9091798a6398e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:13.919541) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:13.921660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:13.921996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:13.937369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:13.937796) ========= 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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 07:07:13-- 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% 113M=0s 2016-05-25 07:07:14 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101858 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:14.053811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:14.054140) ========= 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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013784 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:14.104718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 07:07:14.105281) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dd37cbc7e54337e7048e8aea6a9091798a6398e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dd37cbc7e54337e7048e8aea6a9091798a6398e3 --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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 07:07:14,152 truncating revision to first 12 chars 2016-05-25 07:07:14,152 Setting DEBUG logging. 2016-05-25 07:07:14,152 attempt 1/10 2016-05-25 07:07:14,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dd37cbc7e543?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 07:07:15,472 unpacking tar archive at: mozilla-inbound-dd37cbc7e543/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 07:07:15.735998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:15.736305) ========= script_repo_revision: dd37cbc7e54337e7048e8aea6a9091798a6398e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:15.736718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:15.736985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 07:07:15.747466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-25 07:07:15.747787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:07:15 INFO - MultiFileLogger online at 20160525 07:07:15 in /builds/slave/test 07:07:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:15 INFO - {'append_to_log': False, 07:07:15 INFO - 'base_work_dir': '/builds/slave/test', 07:07:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:15 INFO - 'branch': 'Mozilla-Inbound', 07:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:15 INFO - 'config_files': ('talos/linux_config.py',), 07:07:15 INFO - 'default_actions': ('clobber', 07:07:15 INFO - 'read-buildbot-config', 07:07:15 INFO - 'download-and-extract', 07:07:15 INFO - 'populate-webroot', 07:07:15 INFO - 'create-virtualenv', 07:07:15 INFO - 'install', 07:07:15 INFO - 'run-tests'), 07:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:15 INFO - 'download_minidump_stackwalk': True, 07:07:15 INFO - 'download_symbols': 'ondemand', 07:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:15 INFO - 'installer_path': 'installer.exe', 07:07:15 INFO - 'log_level': 'info', 07:07:15 INFO - 'log_name': 'talos', 07:07:15 INFO - 'log_to_console': True, 07:07:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:07:15 INFO - 'opt_config_files': (), 07:07:15 INFO - 'pip_index': False, 07:07:15 INFO - 'sps_profile': False, 07:07:15 INFO - 'sps_profile_interval': 0, 07:07:15 INFO - 'suite': 'dromaeojs', 07:07:15 INFO - 'system_bits': '32', 07:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:15 INFO - 'title': 'talos-linux64-ix-056', 07:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:15 INFO - 'use_talos_json': True, 07:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:15 INFO - 'work_dir': 'build'} 07:07:15 INFO - ##### 07:07:15 INFO - ##### Running clobber step. 07:07:15 INFO - ##### 07:07:15 INFO - Running pre-action listener: _resource_record_pre_action 07:07:15 INFO - Running main action method: clobber 07:07:15 INFO - rmtree: /builds/slave/test/build 07:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:16 INFO - Running post-action listener: _resource_record_post_action 07:07:16 INFO - ##### 07:07:16 INFO - ##### Finished clobber step (success) 07:07:16 INFO - ##### 07:07:16 INFO - ##### 07:07:16 INFO - ##### Running read-buildbot-config step. 07:07:16 INFO - ##### 07:07:16 INFO - Running pre-action listener: _resource_record_pre_action 07:07:16 INFO - Running main action method: read_buildbot_config 07:07:16 INFO - Using buildbot properties: 07:07:16 INFO - { 07:07:16 INFO - "project": "", 07:07:16 INFO - "product": "firefox", 07:07:16 INFO - "script_repo_revision": "production", 07:07:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:07:16 INFO - "repository": "", 07:07:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:07:16 INFO - "buildid": "20160525043017", 07:07:16 INFO - "pgo_build": "True", 07:07:16 INFO - "basedir": "/builds/slave/test", 07:07:16 INFO - "buildnumber": 981, 07:07:16 INFO - "slavename": "talos-linux64-ix-056", 07:07:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:07:16 INFO - "platform": "ubuntu64_hw", 07:07:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:07:16 INFO - "branch": "mozilla-inbound", 07:07:16 INFO - "repo_path": "integration/mozilla-inbound", 07:07:16 INFO - "revision": "dd37cbc7e54337e7048e8aea6a9091798a6398e3", 07:07:16 INFO - "stage_platform": "linux64-pgo", 07:07:16 INFO - "builduid": "736489b55a6c4ba6bdfd8331fc145635", 07:07:16 INFO - "slavebuilddir": "test" 07:07:16 INFO - } 07:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:07:16 INFO - Running post-action listener: _resource_record_post_action 07:07:16 INFO - ##### 07:07:16 INFO - ##### Finished read-buildbot-config step (success) 07:07:16 INFO - ##### 07:07:16 INFO - ##### 07:07:16 INFO - ##### Running download-and-extract step. 07:07:16 INFO - ##### 07:07:16 INFO - Running pre-action listener: _resource_record_pre_action 07:07:16 INFO - Running main action method: download_and_extract 07:07:16 INFO - mkdir: /builds/slave/test/build/tests 07:07:16 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')]} 07:07:16 INFO - https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:21 INFO - Downloaded 1361 bytes. 07:07:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:07:21 INFO - Using the following test package requirements: 07:07:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:07:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:07:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'jsshell-linux-x86_64.zip'], 07:07:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:07:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:07:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:07:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:07:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:07:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:21 INFO - https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:24 INFO - Downloaded 24408336 bytes. 07:07:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:07:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:07:25 INFO - Return code: 0 07:07:25 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 07:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:25 INFO - https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:32 INFO - Downloaded 24408336 bytes. 07:07:32 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'] 07:07:32 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 07:07:34 INFO - Return code: 0 07:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:34 INFO - https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:35 INFO - Downloaded 10834034 bytes. 07:07:35 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'] 07:07:35 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 07:07:35 INFO - Return code: 0 07:07: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')]} 07:07:35 INFO - https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/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 07:07:36 INFO - Downloaded 58642724 bytes. 07:07:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:07:36 INFO - mkdir: /builds/slave/test/properties 07:07:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:36 INFO - Contents: 07:07:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:07:37 INFO - Running post-action listener: _resource_record_post_action 07:07:37 INFO - Running post-action listener: set_extra_try_arguments 07:07:37 INFO - ##### 07:07:37 INFO - ##### Finished download-and-extract step (success) 07:07:37 INFO - ##### 07:07:37 INFO - ##### 07:07:37 INFO - ##### Running populate-webroot step. 07:07:37 INFO - ##### 07:07:37 INFO - Running pre-action listener: _resource_record_pre_action 07:07:37 INFO - Running main action method: populate_webroot 07:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:37 INFO - '--tppagecycles', 07:07:37 INFO - '7'], 07:07:37 INFO - 'tests': ['tsvgm']}}, 07:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['damp', 'tps']}, 07:07:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'tests': ['damp', 'tps']}, 07:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['dromaeo_dom']}, 07:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['a11yr', 07:07:37 INFO - 'ts_paint', 07:07:37 INFO - 'tpaint', 07:07:37 INFO - 'sessionrestore', 07:07:37 INFO - 'sessionrestore_no_auto_restore', 07:07:37 INFO - 'tabpaint']}, 07:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['tsvgx', 07:07:37 INFO - 'tsvgr_opacity', 07:07:37 INFO - 'tart', 07:07:37 INFO - 'tscrollx', 07:07:37 INFO - 'cart']}, 07:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:37 INFO - 'tsvgr_opacity', 07:07:37 INFO - 'tart', 07:07:37 INFO - 'tscrollx', 07:07:37 INFO - 'cart']}, 07:07:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'talos_options': ['--disable-e10s'], 07:07:37 INFO - 'tests': ['tp5o']}, 07:07:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'tests': ['tp5o']}, 07:07:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'talos_options': ['--disable-e10s', 07:07:37 INFO - '--xperf_path', 07:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:37 INFO - 'tests': ['tp5n']}, 07:07:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:37 INFO - 'talos_options': ['--xperf_path', 07:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:37 INFO - 'tests': ['tp5n']}}, 07:07:37 INFO - 'talos.zip': {'path': '', 07:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:37 INFO - Running post-action listener: _resource_record_post_action 07:07:37 INFO - ##### 07:07:37 INFO - ##### Finished populate-webroot step (success) 07:07:37 INFO - ##### 07:07:37 INFO - ##### 07:07:37 INFO - ##### Running create-virtualenv step. 07:07:37 INFO - ##### 07:07:37 INFO - Running pre-action listener: _resource_record_pre_action 07:07:37 INFO - Running main action method: create_virtualenv 07:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:37 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 07:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:37 INFO - Using real prefix '/usr' 07:07:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:40 INFO - Installing pip.................done. 07:07:40 INFO - Return code: 0 07:07:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:40 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')]} 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:40 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')]} 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:40 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:40 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 07:07:40 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 07:07:40 INFO - Using env: {'DISPLAY': ':0', 07:07:40 INFO - 'HOME': '/home/cltbld', 07:07:40 INFO - 'LANG': 'en_US.UTF-8', 07:07:40 INFO - 'LANGUAGE': 'en_US:en', 07:07:40 INFO - 'LOGNAME': 'cltbld', 07:07:40 INFO - 'MAIL': '/var/mail/cltbld', 07:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:40 INFO - 'MOZ_NO_REMOTE': '1', 07:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:40 INFO - 'NO_EM_RESTART': '1', 07:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:40 INFO - 'PWD': '/builds/slave/test', 07:07:40 INFO - 'SHELL': '/bin/bash', 07:07:40 INFO - 'SHLVL': '1', 07:07:40 INFO - 'TERM': 'linux', 07:07:40 INFO - 'TMOUT': '86400', 07:07:40 INFO - 'USER': 'cltbld', 07:07:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:40 INFO - '_': '/tools/buildbot/bin/python'} 07:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:40 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 07:07:40 INFO - Cleaning up... 07:07:40 INFO - Return code: 0 07:07:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:07:40 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')]} 07:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:40 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')]} 07:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:40 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:40 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 07:07:40 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 07:07:40 INFO - Using env: {'DISPLAY': ':0', 07:07:40 INFO - 'HOME': '/home/cltbld', 07:07:40 INFO - 'LANG': 'en_US.UTF-8', 07:07:40 INFO - 'LANGUAGE': 'en_US:en', 07:07:40 INFO - 'LOGNAME': 'cltbld', 07:07:40 INFO - 'MAIL': '/var/mail/cltbld', 07:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:40 INFO - 'MOZ_NO_REMOTE': '1', 07:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:40 INFO - 'NO_EM_RESTART': '1', 07:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:40 INFO - 'PWD': '/builds/slave/test', 07:07:40 INFO - 'SHELL': '/bin/bash', 07:07:40 INFO - 'SHLVL': '1', 07:07:40 INFO - 'TERM': 'linux', 07:07:40 INFO - 'TMOUT': '86400', 07:07:40 INFO - 'USER': 'cltbld', 07:07:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:40 INFO - '_': '/tools/buildbot/bin/python'} 07:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:40 INFO - Downloading/unpacking psutil>=3.1.1 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:42 INFO - Installing collected packages: psutil 07:07:42 INFO - Running setup.py install for psutil 07:07:42 INFO - building 'psutil._psutil_linux' extension 07:07:42 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 07:07:42 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 07:07:43 INFO - building 'psutil._psutil_posix' extension 07:07:43 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 07:07:43 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 07:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:43 INFO - Successfully installed psutil 07:07:43 INFO - Cleaning up... 07:07:43 INFO - Return code: 0 07:07:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:07:43 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')]} 07:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:43 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')]} 07:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:43 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:43 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 07:07:43 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 07:07:43 INFO - Using env: {'DISPLAY': ':0', 07:07:43 INFO - 'HOME': '/home/cltbld', 07:07:43 INFO - 'LANG': 'en_US.UTF-8', 07:07:43 INFO - 'LANGUAGE': 'en_US:en', 07:07:43 INFO - 'LOGNAME': 'cltbld', 07:07:43 INFO - 'MAIL': '/var/mail/cltbld', 07:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:43 INFO - 'MOZ_NO_REMOTE': '1', 07:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:43 INFO - 'NO_EM_RESTART': '1', 07:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:43 INFO - 'PWD': '/builds/slave/test', 07:07:43 INFO - 'SHELL': '/bin/bash', 07:07:43 INFO - 'SHLVL': '1', 07:07:43 INFO - 'TERM': 'linux', 07:07:43 INFO - 'TMOUT': '86400', 07:07:43 INFO - 'USER': 'cltbld', 07:07:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:43 INFO - '_': '/tools/buildbot/bin/python'} 07:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:07:45 INFO - Installing collected packages: mozsystemmonitor 07:07:45 INFO - Running setup.py install for mozsystemmonitor 07:07:45 INFO - Successfully installed mozsystemmonitor 07:07:45 INFO - Cleaning up... 07:07:45 INFO - Return code: 0 07:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:07:45 INFO - Using env: {'DISPLAY': ':0', 07:07:45 INFO - 'HOME': '/home/cltbld', 07:07:45 INFO - 'LANG': 'en_US.UTF-8', 07:07:45 INFO - 'LANGUAGE': 'en_US:en', 07:07:45 INFO - 'LOGNAME': 'cltbld', 07:07:45 INFO - 'MAIL': '/var/mail/cltbld', 07:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:45 INFO - 'MOZ_NO_REMOTE': '1', 07:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:45 INFO - 'NO_EM_RESTART': '1', 07:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:45 INFO - 'PWD': '/builds/slave/test', 07:07:45 INFO - 'SHELL': '/bin/bash', 07:07:45 INFO - 'SHLVL': '1', 07:07:45 INFO - 'TERM': 'linux', 07:07:45 INFO - 'TMOUT': '86400', 07:07:45 INFO - 'USER': 'cltbld', 07:07:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:45 INFO - '_': '/tools/buildbot/bin/python'} 07:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:48 INFO - Downloading docopt-0.6.1.tar.gz 07:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:48 INFO - Running setup.py install for blobuploader 07:07:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:48 INFO - Running setup.py install for requests 07:07:49 INFO - Running setup.py install for docopt 07:07:49 INFO - Successfully installed blobuploader requests docopt 07:07:49 INFO - Cleaning up... 07:07:49 INFO - Return code: 0 07:07:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:49 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:49 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 07:07:49 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 07:07:49 INFO - Using env: {'DISPLAY': ':0', 07:07:49 INFO - 'HOME': '/home/cltbld', 07:07:49 INFO - 'LANG': 'en_US.UTF-8', 07:07:49 INFO - 'LANGUAGE': 'en_US:en', 07:07:49 INFO - 'LOGNAME': 'cltbld', 07:07:49 INFO - 'MAIL': '/var/mail/cltbld', 07:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:49 INFO - 'MOZ_NO_REMOTE': '1', 07:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:49 INFO - 'NO_EM_RESTART': '1', 07:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:49 INFO - 'PWD': '/builds/slave/test', 07:07:49 INFO - 'SHELL': '/bin/bash', 07:07:49 INFO - 'SHLVL': '1', 07:07:49 INFO - 'TERM': 'linux', 07:07:49 INFO - 'TMOUT': '86400', 07:07:49 INFO - 'USER': 'cltbld', 07:07:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:49 INFO - '_': '/tools/buildbot/bin/python'} 07:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:49 INFO - Running setup.py (path:/tmp/pip-fJPaKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:49 INFO - Running setup.py (path:/tmp/pip-RRy2N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:49 INFO - Running setup.py (path:/tmp/pip-IeKOho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:49 INFO - Running setup.py (path:/tmp/pip-Po6pua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:49 INFO - Running setup.py (path:/tmp/pip-DnbFfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:50 INFO - Running setup.py (path:/tmp/pip-ONjnVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:50 INFO - Running setup.py (path:/tmp/pip-bCYq2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:50 INFO - Running setup.py (path:/tmp/pip-I79zHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:50 INFO - Running setup.py (path:/tmp/pip-qtQJeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:50 INFO - Running setup.py (path:/tmp/pip-8Ic_DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:50 INFO - Running setup.py (path:/tmp/pip-zVJiuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:50 INFO - Running setup.py (path:/tmp/pip-zTrEng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:50 INFO - Running setup.py (path:/tmp/pip-tK7B1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:50 INFO - Running setup.py (path:/tmp/pip-1mRIsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:50 INFO - Running setup.py (path:/tmp/pip-xftKub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:50 INFO - Running setup.py (path:/tmp/pip-XQtMbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:50 INFO - Running setup.py (path:/tmp/pip-aWafsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:50 INFO - Running setup.py install for manifestparser 07:07:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for mozcrash 07:07:51 INFO - Running setup.py install for mozdebug 07:07:51 INFO - Running setup.py install for mozdevice 07:07:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for mozfile 07:07:51 INFO - Running setup.py install for mozhttpd 07:07:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for mozinfo 07:07:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for mozInstall 07:07:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for mozleak 07:07:51 INFO - Running setup.py install for mozlog 07:07:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:07:51 INFO - Running setup.py install for moznetwork 07:07:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Running setup.py install for mozprocess 07:07:52 INFO - Running setup.py install for mozprofile 07:07:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Running setup.py install for mozrunner 07:07:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Running setup.py install for mozscreenshot 07:07:52 INFO - Running setup.py install for moztest 07:07:52 INFO - Running setup.py install for mozversion 07:07:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:07:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:52 INFO - Cleaning up... 07:07:52 INFO - Return code: 0 07:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:52 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 07:07:52 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 07:07:52 INFO - Using env: {'DISPLAY': ':0', 07:07:52 INFO - 'HOME': '/home/cltbld', 07:07:52 INFO - 'LANG': 'en_US.UTF-8', 07:07:52 INFO - 'LANGUAGE': 'en_US:en', 07:07:52 INFO - 'LOGNAME': 'cltbld', 07:07:52 INFO - 'MAIL': '/var/mail/cltbld', 07:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:52 INFO - 'MOZ_NO_REMOTE': '1', 07:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:52 INFO - 'NO_EM_RESTART': '1', 07:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:52 INFO - 'PWD': '/builds/slave/test', 07:07:52 INFO - 'SHELL': '/bin/bash', 07:07:52 INFO - 'SHLVL': '1', 07:07:52 INFO - 'TERM': 'linux', 07:07:52 INFO - 'TMOUT': '86400', 07:07:52 INFO - 'USER': 'cltbld', 07:07:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:52 INFO - '_': '/tools/buildbot/bin/python'} 07:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:52 INFO - Running setup.py (path:/tmp/pip-2pU6yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:53 INFO - Running setup.py (path:/tmp/pip-Mh_CId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:53 INFO - Running setup.py (path:/tmp/pip-qQqhlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:53 INFO - Running setup.py (path:/tmp/pip-XGTOmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:53 INFO - Running setup.py (path:/tmp/pip-g3G96Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:53 INFO - Running setup.py (path:/tmp/pip-IAVQwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:53 INFO - Running setup.py (path:/tmp/pip-RW2AHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:53 INFO - Running setup.py (path:/tmp/pip-Hk1dAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:53 INFO - Running setup.py (path:/tmp/pip-iyr6HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:53 INFO - Running setup.py (path:/tmp/pip-7RWSxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:53 INFO - Running setup.py (path:/tmp/pip-e_RN0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:53 INFO - Running setup.py (path:/tmp/pip-Gsm3Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:53 INFO - Running setup.py (path:/tmp/pip-Mvol4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:53 INFO - Running setup.py (path:/tmp/pip-1MKUBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:53 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)) 07:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:53 INFO - Running setup.py (path:/tmp/pip-R5kqTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:54 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)) 07:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:54 INFO - Running setup.py (path:/tmp/pip-vYfczT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:54 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)) 07:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:54 INFO - Running setup.py (path:/tmp/pip-KsYmXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:54 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)) 07:07:54 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)) 07:07:54 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)) 07:07:54 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)) 07:07:54 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)) 07:07:54 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)) 07:07:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:56 INFO - Downloading blessings-1.6.tar.gz 07:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:56 INFO - Installing collected packages: blessings 07:07:56 INFO - Running setup.py install for blessings 07:07:56 INFO - Successfully installed blessings 07:07:56 INFO - Cleaning up... 07:07:56 INFO - Return code: 0 07:07:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:56 INFO - Reading from file tmpfile_stdout 07:07:56 INFO - Current package versions: 07:07:56 INFO - argparse == 1.2.1 07:07:56 INFO - blessings == 1.6 07:07:56 INFO - blobuploader == 1.2.4 07:07:56 INFO - docopt == 0.6.1 07:07:56 INFO - manifestparser == 1.1 07:07:56 INFO - mozInstall == 1.12 07:07:56 INFO - mozcrash == 0.17 07:07:56 INFO - mozdebug == 0.1 07:07:56 INFO - mozdevice == 0.48 07:07:56 INFO - mozfile == 1.2 07:07:56 INFO - mozhttpd == 0.7 07:07:56 INFO - mozinfo == 0.9 07:07:56 INFO - mozleak == 0.1 07:07:56 INFO - mozlog == 3.2 07:07:56 INFO - moznetwork == 0.27 07:07:56 INFO - mozprocess == 0.22 07:07:56 INFO - mozprofile == 0.28 07:07:56 INFO - mozrunner == 6.11 07:07:56 INFO - mozscreenshot == 0.1 07:07:56 INFO - mozsystemmonitor == 0.3 07:07:56 INFO - moztest == 0.7 07:07:56 INFO - mozversion == 1.4 07:07:56 INFO - psutil == 3.1.1 07:07:56 INFO - requests == 1.2.3 07:07:56 INFO - wsgiref == 0.1.2 07:07:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:56 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')]} 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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')]} 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:56 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 07:07:56 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 07:07:56 INFO - Using env: {'DISPLAY': ':0', 07:07:56 INFO - 'HOME': '/home/cltbld', 07:07:56 INFO - 'LANG': 'en_US.UTF-8', 07:07:56 INFO - 'LANGUAGE': 'en_US:en', 07:07:56 INFO - 'LOGNAME': 'cltbld', 07:07:56 INFO - 'MAIL': '/var/mail/cltbld', 07:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:56 INFO - 'MOZ_NO_REMOTE': '1', 07:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:56 INFO - 'NO_EM_RESTART': '1', 07:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:56 INFO - 'PWD': '/builds/slave/test', 07:07:56 INFO - 'SHELL': '/bin/bash', 07:07:56 INFO - 'SHLVL': '1', 07:07:56 INFO - 'TERM': 'linux', 07:07:56 INFO - 'TMOUT': '86400', 07:07:56 INFO - 'USER': 'cltbld', 07:07:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:56 INFO - '_': '/tools/buildbot/bin/python'} 07:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 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)) 07:07:56 INFO - Cleaning up... 07:07:56 INFO - Return code: 0 07:07:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:07:56 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')]} 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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')]} 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:56 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 07:07:56 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 07:07:56 INFO - Using env: {'DISPLAY': ':0', 07:07:56 INFO - 'HOME': '/home/cltbld', 07:07:56 INFO - 'LANG': 'en_US.UTF-8', 07:07:56 INFO - 'LANGUAGE': 'en_US:en', 07:07:56 INFO - 'LOGNAME': 'cltbld', 07:07:56 INFO - 'MAIL': '/var/mail/cltbld', 07:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:56 INFO - 'MOZ_NO_REMOTE': '1', 07:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:56 INFO - 'NO_EM_RESTART': '1', 07:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:56 INFO - 'PWD': '/builds/slave/test', 07:07:56 INFO - 'SHELL': '/bin/bash', 07:07:56 INFO - 'SHLVL': '1', 07:07:56 INFO - 'TERM': 'linux', 07:07:56 INFO - 'TMOUT': '86400', 07:07:56 INFO - 'USER': 'cltbld', 07:07:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:56 INFO - '_': '/tools/buildbot/bin/python'} 07:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:56 INFO - Downloading/unpacking jsonschema 07:07:56 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 07:07:56 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 07:07:56 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 07:07:56 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 07:07:56 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 07:07:56 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 07:07:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:58 INFO - Downloading/unpacking functools32 (from jsonschema) 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:59 INFO - warning: no files found matching '*.txt' 07:07:59 INFO - no previously-included directories found matching 'build' 07:07:59 INFO - no previously-included directories found matching 'dist' 07:07:59 INFO - no previously-included directories found matching '.git*' 07:07:59 INFO - Installing collected packages: jsonschema, functools32 07:07:59 INFO - Running setup.py install for functools32 07:07:59 INFO - warning: no files found matching '*.txt' 07:07:59 INFO - no previously-included directories found matching 'build' 07:07:59 INFO - no previously-included directories found matching 'dist' 07:07:59 INFO - no previously-included directories found matching '.git*' 07:07:59 INFO - Successfully installed jsonschema functools32 07:07:59 INFO - Cleaning up... 07:07:59 INFO - Return code: 0 07:07:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:07:59 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')]} 07:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:59 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')]} 07:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:59 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 0x7f0c0441cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, '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': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', '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 07:07:59 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 07:07:59 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 07:07:59 INFO - Using env: {'DISPLAY': ':0', 07:07:59 INFO - 'HOME': '/home/cltbld', 07:07:59 INFO - 'LANG': 'en_US.UTF-8', 07:07:59 INFO - 'LANGUAGE': 'en_US:en', 07:07:59 INFO - 'LOGNAME': 'cltbld', 07:07:59 INFO - 'MAIL': '/var/mail/cltbld', 07:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:59 INFO - 'MOZ_NO_REMOTE': '1', 07:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:59 INFO - 'NO_EM_RESTART': '1', 07:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:59 INFO - 'PWD': '/builds/slave/test', 07:07:59 INFO - 'SHELL': '/bin/bash', 07:07:59 INFO - 'SHLVL': '1', 07:07:59 INFO - 'TERM': 'linux', 07:07:59 INFO - 'TMOUT': '86400', 07:07:59 INFO - 'USER': 'cltbld', 07:07:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:59 INFO - '_': '/tools/buildbot/bin/python'} 07:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:59 INFO - Downloading/unpacking flake8 07:07:59 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 07:07:59 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 07:07:59 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 07:07:59 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 07:07:59 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 07:07:59 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 07:08:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:08:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:08:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:01 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 07:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:02 INFO - no previously-included directories found matching 'docs/_build' 07:08:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:08:02 INFO - Running setup.py install for pep8 07:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:02 INFO - no previously-included directories found matching 'docs/_build' 07:08:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:08:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:08:02 INFO - Cleaning up... 07:08:02 INFO - Return code: 0 07:08:02 INFO - Running post-action listener: _resource_record_post_action 07:08:02 INFO - Running post-action listener: _start_resource_monitoring 07:08:02 INFO - Starting resource monitoring. 07:08:02 INFO - ##### 07:08:02 INFO - ##### Finished create-virtualenv step (success) 07:08:02 INFO - ##### 07:08:02 INFO - ##### 07:08:02 INFO - ##### Running install step. 07:08:02 INFO - ##### 07:08:02 INFO - Running pre-action listener: _resource_record_pre_action 07:08:02 INFO - Running main action method: install 07:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:02 INFO - Reading from file tmpfile_stdout 07:08:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:02 INFO - Reading from file tmpfile_stdout 07:08:02 INFO - Output received: 07:08:02 INFO - Usage: mozinstall [options] installer 07:08:02 INFO - Options: 07:08:02 INFO - -h, --help show this help message and exit 07:08:02 INFO - -d DEST, --destination=DEST 07:08:02 INFO - Directory to install application into. [default: 07:08:02 INFO - "/builds/slave/test"] 07:08:02 INFO - --app=APP Application being installed. [default: firefox] 07:08:02 INFO - mkdir: /builds/slave/test/build/application 07:08:02 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'] 07:08:02 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 07:08:19 INFO - Reading from file tmpfile_stdout 07:08:19 INFO - Output received: 07:08:19 INFO - /builds/slave/test/build/application/firefox/firefox 07:08:19 INFO - Running post-action listener: _resource_record_post_action 07:08:19 INFO - ##### 07:08:19 INFO - ##### Finished install step (success) 07:08:19 INFO - ##### 07:08:19 INFO - ##### 07:08:19 INFO - ##### Running run-tests step. 07:08:19 INFO - ##### 07:08:19 INFO - Running pre-action listener: _resource_record_pre_action 07:08:19 INFO - Running main action method: run_tests 07:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:19 INFO - Python 2.7.3 07:08:19 INFO - Return code: 0 07:08:19 INFO - grabbing minidump binary from tooltool 07:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:19 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 0x29309c0>, '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 0x29318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:19 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 07:08:19 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 07:08:19 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 07:08:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:19 INFO - Return code: 0 07:08:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:08:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:08:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:08:20 INFO - Return code: 0 07:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:08:20 INFO - Using env: {'DISPLAY': ':0', 07:08:20 INFO - 'HOME': '/home/cltbld', 07:08:20 INFO - 'LANG': 'en_US.UTF-8', 07:08:20 INFO - 'LANGUAGE': 'en_US:en', 07:08:20 INFO - 'LOGNAME': 'cltbld', 07:08:20 INFO - 'MAIL': '/var/mail/cltbld', 07:08:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:20 INFO - 'MOZ_NO_REMOTE': '1', 07:08:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:20 INFO - 'NO_EM_RESTART': '1', 07:08:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:20 INFO - 'PWD': '/builds/slave/test', 07:08:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:20 INFO - 'SHELL': '/bin/bash', 07:08:20 INFO - 'SHLVL': '1', 07:08:20 INFO - 'TERM': 'linux', 07:08:20 INFO - 'TMOUT': '86400', 07:08:20 INFO - 'USER': 'cltbld', 07:08:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079', 07:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:20 INFO - '_': '/tools/buildbot/bin/python'} 07:08:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:08:20 INFO - mozversion application_buildid: 20160525043017 07:08:20 INFO - mozversion application_changeset: dd37cbc7e54337e7048e8aea6a9091798a6398e3 07:08:20 INFO - mozversion application_display_name: Nightly 07:08:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:20 INFO - mozversion application_name: Firefox 07:08:20 INFO - mozversion application_remotingname: firefox 07:08:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:08:20 INFO - mozversion application_vendor: Mozilla 07:08:20 INFO - mozversion application_version: 49.0a1 07:08:20 INFO - mozversion platform_buildid: 20160525043017 07:08:20 INFO - mozversion platform_changeset: dd37cbc7e54337e7048e8aea6a9091798a6398e3 07:08:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:08:20 INFO - mozversion platform_version: 49.0a1 07:08:20 INFO - using testdate: 1464185300 07:08:20 INFO - actual date: 1464185300 07:08:20 INFO - starting webserver on 'localhost:60581' 07:08:20 INFO - SUITE-START | Running 2 tests 07:08:20 INFO - TEST-START | dromaeo_css 07:08:20 INFO - operating with platform_type : linux_ 07:08:20 INFO - Initialising browser for dromaeo_css test... 07:08:20 INFO - TEST-INFO | started process 5339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcgHI4/profile http://localhost:60581/getInfo.html) 07:08:24 INFO - PROCESS | 5339 | __metrics Screen width/height:1600/1200 07:08:24 INFO - PROCESS | 5339 | colorDepth:24 07:08:24 INFO - PROCESS | 5339 | Browser inner width/height: 1024/697 07:08:24 INFO - PROCESS | 5339 | __metrics 07:08:26 ERROR - PROCESS | 5339 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:08:26 INFO - TEST-INFO | 5339: exit 0 07:08:26 INFO - Browser initialized. 07:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:26 INFO - TEST-INFO | started process 5419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcgHI4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:38 INFO - PROCESS | 5419 | RSS: Main: 155357184 07:08:38 INFO - PROCESS | 5419 | 07:09:29 INFO - PROCESS | 5419 | 1464185369726 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] 07:11:37 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60581/tests/dromaeo/cssquery-ext.html) 07:11:38 INFO - PROCESS | 5419 | RSS: Main: 251011072 07:11:38 INFO - PROCESS | 5419 | 07:14:40 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-ext.html (next: http://localhost:60581/tests/dromaeo/cssquery-jquery.html) 07:14:41 INFO - PROCESS | 5419 | RSS: Main: 237907968 07:14:41 INFO - PROCESS | 5419 | 07:17:43 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60581/tests/dromaeo/cssquery-mootools.html) 07:17:44 INFO - PROCESS | 5419 | RSS: Main: 235102208 07:17:44 INFO - PROCESS | 5419 | 07:20:46 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60581/tests/dromaeo/cssquery-prototype.html) 07:20:46 INFO - PROCESS | 5419 | RSS: Main: 234958848 07:20:46 INFO - PROCESS | 5419 | 07:23:49 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60581/tests/dromaeo/cssquery-yui.html) 07:23:49 INFO - PROCESS | 5419 | RSS: Main: 220123136 07:23:49 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | Cycle 1(1): loaded http://localhost:60581/tests/dromaeo/cssquery-yui.html (next: http://localhost:60581/tests/dromaeo/cssquery-dojo.html) 07:26:52 INFO - PROCESS | 5419 | RSS: Main: 270295040 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | __start_tp_report 07:26:52 INFO - PROCESS | 5419 | _x_x_mozilla_page_load 07:26:52 INFO - PROCESS | 5419 | _x_x_mozilla_page_load_details 07:26:52 INFO - PROCESS | 5419 | |i|pagename|runs| 07:26:52 INFO - PROCESS | 5419 | |0;dojo.html;3072.201227680803;3079.3687294104698;3103.4568950433677;3113.891013814517;3141.104785136237;5098.515641014107;5194.818181363653;5218.982298451799;5295.841124766258;5302.4697530247;5131.435542090367;5212.817551385693;5221.921671174935;5226.4512226216175;5267.446918073604;4671.182543054969;4717.245240761479;4751.857444276678;4760.90478190436;4905.0925578767865;4753.928691069636;4793.041391721669;4805.111054454919;4811.663183577151;4832.226843705008;4647.093816705744;4697.412823397075;4699.130660827758;4709.764511774431;4763.547462990993;4714.599259062949;4724.480307166209;4784.712917224978;4795.640326975491;4825.1555977703765;4594.770261486912;4754.072955773626;4759.714417134983;4760.357351757503;4807.687500312469;5138.152204886189;5185.714785686786;5197.558207552363;5246.265522826808;5262.973685131588;5627.971860140714;5681.687507187145;5705.258316418881;5708.514776244025;5715.2855893013375;5456.181572764117;5587.8603034924045;5613.045782217033;5747.1666608341975;5753.395893431171;5313.867153321198;5345.679259244458;5356.223347614574;5363.865903352408;5369.033573956686;5837.124431335334;5862.677552734641;5869.090291004901;5888.852778680482;5889.352171261158;5345.599080069011;5462.672239665553;5513.42109078549;5540.556755459635;5634.464725851038;5662.094064949588;5662.320521537442;5724.484796368263;5725.370209276976;5730.856728581735;5610.971945140248;5613.186088017296;5627.915581266284;5631.352394474606;5644.520215781622;5440.591955603346;5609.523190528851;5640.182173584889;5664.971675141598;5696.629719068247;4349.28236840924;4350.543192964757;4361.781910904442;4369.628581570539;4382.05785756064;3804.334241507725;3891.5719270880745;3900.473436086149;3942.290387730236;3953.723239373216;5362.088444964365;5434.809781657623;5439.401665816757;5450.264214331094;5452.40023597404;5665.575081868877;5690.943090569124;5702.372738998707;5708.372079071299;5762.798302059407;5396.2984811974975;5435.456454354533;5441.183822426588;5455.645383050169;5456.399796022434;4772;4773.618110551148;4881;4881.4630390657;4892.657513973988;5818.214541036906;5829.7376618052285;5832.445917637902;5836.678982655994;5841.591088623755;5546.057170280981;5628.634138780966;5630.18362337467;5639.6334238274385;5639.7180140993605;5778.971105144616;5782.190493331022;5804.564657650778;5863.091220860773;5866.061430171152;5517.337919449692;5532.778688852401;5540.584456165723;5541.944580554143;5552.500824777207;5429.267048948342;5637.43625637433;5645.491905728504;5652.378238393691;5657.773689052392;5420.9186862197885;5429.457054294539;5446.509814116748;5479.424660410599;5491.039068162976;5448.346198456211;5470.671759694431;5475.4524547544925;5492.47821456961;5506.091494903296;5238.978399212117;5397.676139431646;5462.235287059735;5465.043617367024;5506.311711036121;5573;5662.5469962402085;5669.34802497718;5669.801556945652;5670.291213598301;5425.511703946664;5465.934142842108;5466.234727138283;5474.069408200536;5502.202180683858 07:26:52 INFO - PROCESS | 5419 | |1;ext.html;594.9464548190665;621.1707370660168;629.8645791154902;637.4422380417134;640.2477089419928;32573.67426325739;42807.57192428079;43659.12681746371;43845;43933.56066439335;45387.77306113465;45885.7705711471;45908;45941.081178376415;45947;7805.4145939054515;8656.697015604455;8874.112588741107;8884.689035883745;10123.341982771133;10091.545880435362;10502;10561.313514621563;10569.947150264237;10578.206634502405;10499.790004199911;10567.15462762981;10576.10103141234;10577.629782957598;10591.417472039035;8005.359571234317;10246.48767561619;10536.841947370758;10595.629152979609;10611.204159687977;10315.277930544866;10340.638077667245;10353.223508236912;10404.063634272876;10457;41409;42222.155556888996;42240.155196896194;42346.364804527955;42422.36366454505;3233;3501.6848483636595;3504.6144924058335;3538.486919396699;3625.4199328107375;30726.84636576803;32262.354752904812;32707.836460817543;32802;32832.50751238733;4330.950561225264;4343.305071188626;4517.186906356855;4524.61540769035;4544.954550454486;337743;338356;338671;338960;339268;60460;60537.09194362088;60720.089198662055;60858;60935.08597371043;62929.68535157386;63610;63665;63725.40686482875;63781.36218637754;16512.09183494895;16979.40572079996;16983.83016169847;16991;17011.574710632332;12184.329861857506;12236.858549753757;12242.877571224351;12445.128840981226;12455;19136.234550618097;19690.31083912056;19728.210871565265;19839.404817855488;19853.801461985197;6178.41305076017;7014.964925175342;7167.713291468387;7169.462290328246;7215.386692131227;1018.2057994764095;1044.9216308776872;1064.3826580583243;1173.0322483950774;1221.7984032634693;30751.61811495804;32229.51655725166;32429.35141297161;32520;32563.51154732681;1088.2200183018851;1092.759592889563;1115.9274647147909;1128.774245150973;1132.5866058888446;16425.83574164267;16636.08501532427;16958.915205423895;16992.830071699373;17057.829421705872;563071;569494;569808;569880;570683;56897.43102569004;58068;58280.12579811221;58458.707706461195;58642;1295.6825577733516;1375.7179778145455;1391.0679844504207;1402.4530433131088;1403.39653948803;29752.082487297488;30776.69223307828;30997;31275.53086703747;31293.8435307822;50050.49949500604;50523.49476505188;50699.239511408094;50727.492725072276;50764.669709679954;476048;479947;480874;481481;482784;24205.51588968246;24883.75116248887;27138.200651908355;27627.86186069057;27925.301867452665;45651.086978260915;47243.291350630454;48354.75822620864;48567.27149092837;48817.511824881294;39950.40074398944;39962.400563992145;40455.381784728284;40839.59160408358;41340.37989430221;40567;40926.181476370904;41036.38445423261;41446.378304324855;41538;41088.38367424431;41354.37968430416;41657;41727.791361043;41842;34485.48271775875;36265.637343627284;36612.633873660925;36842.44736328904;37088;28267.293317667223;28451;28514;28709.42581148407;28823.85588072046 07:26:52 INFO - PROCESS | 5419 | |2;jquery.html;390.29162070841403;395.5589517687779;402.8992751812047;405.1815333027285;424.4863714904965;13675.589732308023;17682.292708291687;17882;19318.710219346704;19385.12766925488;18000.099995000262;18283.451496455094;18864.434066977978;18911.62176756464;19789.307374241904;5656.773729050833;5682.403347648499;5814.302283725959;5819.7672093116435;5819.912701309484;4158.4178215049915;5640.464155905182;5754.251947246873;5763.106718458645;6113.572049956505;6365.395287447685;6453.548251622365;6458.644774537399;6477.9676101619425;6480.902786458183;6270.529710271725;6304.684765761694;6322.589031712924;6448.677566121675;6451.161349024644;5525.254090697745;5692.6299790513485;5706.686132262724;5713.314402271712;5730.856728581777;22772.88613556938;23050.884745576164;23070;23760.524789504114;24954.625680614805;2404.446977195237;2479.454520005614;2509.0591028364365;2911.5195992661183;3356;14324.283785810669;15047.699046019019;15354;15596.766048509282;15829.445969391016;1867.1691097461635;2068.6690129579347;2199.6480563109985;2245.1692873636694;2374.726906405751;90665;91833.54083229607;94465.52767236189;96169.5191524045;100715;17825.376111836023;18042.368517101837;18264;18369.7244541332;18609.162587683586;25973;27874.721252787618;32029.359412811613;32093;32101.35797284041;9947.353422027545;10128.59485620567;10148.289619726696;10162.64430744935;10311.587536498606;8289.010637446969;8401.15988401155;8433.746987590383;8524.95737521321;8615.181557752003;8970.506622135845;8985.910140898508;9079.182873541413;9080.682176123804;9104.180623743763;3525.964740352615;3570.285942811396;3581.964180358163;3613.1870329175727;3636.581793093775;960.8174446855076;1021.8759364698772;1040.5785656809005;1073.1575713065206;1109.9778004439866;18251.72622410665;18938.431847044336;18947.62104757897;19091.2363505461;19249.23003079889;1011.1607365886443;1025.99487002566;1066.2163309967168;1069.1019543583427;1087.217203613397;10455.16358691303;10798.838017429745;10817.188710846718;10923.890761092447;10965.56137754497;435920;439292;439396;470649;475612;56729.71635141798;78072.60963695146;89956;90178;90225.09774902168;968.2689569375218;1003.4731765823001;1003.5433877585681;1007.4408703169811;1021.8211812932856;16538.50384488467;16664.50006499807;16951.576210594834;17101.743473847655;17353.91323043427;32509;33013;36036;38594.2281154381;38816.80591597137;50582.49417505778;54622;55204.44795552154;55746.16380754373;55884.44115558955;8094.271515563628;8462.492250464991;8529.360297977553;8608.526531040603;8611.95694021526;12733.490660373482;13519.594412167256;13653.79519307231;13788.448462061806;13941.651458713613;11628.476718547854;11794.52821887115;11909;12085.093617978511;12263.448144833683;10957.945210273898;11495.77008459843;11665.35840528779;11672.182947193614;11909;9255.444673319622;11507.712307192387;12266.202696824677;12450.194721765474;12714.87285127137;8523.147685231428;8638.185980944072;8750.299976001777;8791.560421979004;8990.505522196341;8878.112188781328;11518.884811151782;11704.648860534198;12233.816492752794;12262.4481898313 07:26:52 INFO - PROCESS | 5419 | |3;mootools.html;1284.9550265740702;1487.1746180869616;1520.1259275916348;1662.7339625659897;1829.3231504343396;8090.91909080909;8539.658413663454;8573;8721.781955451117;8735.650573977033;8407.201315874998;8606.397552171351;8609.526476043815;8612.00961889383;8628.741137765877;2218.134927378324;2235.3629215673536;2241.025154057982;2242.7532971373216;2243.719535058118;2244.753077161511;2249.707538020055;2309.8383113182085;2313;2321.361625552978;2265.5129147233342;2268.0587556164173;2291.6447950567604;2293.7018187635585;2295.6097463431174;2111.5776844631137;2115.650917598602;2131.477787941956;2132.4775430019668;2133.8506304558687;2082.875027498355;2084.1038353507984;2094.434502684282;2096.3501314592527;2097.2554743066144;8423.452475589067;8444.788880278042;8483.872741908875;8495.787605309855;8708.17272359125;4876.853694389174;4971.1549036663855;4972.801087956477;4974.502549745032;4977.477364876709;3078.6921307869256;3134.5925029745986;3151.8739250430185;3174.3016536361965;3191.138392633976;1026.2149455666422;1051.3429106808244;1072.9302595331278;1079.5843600213896;1107.9279846810011;11878.40607969598;12067;12070.577529786504;12072.577459788952;12074.094442916816;4159.9376009359885;4176.561461046607;4179.561146079618;4211.915761684749;4312.805923733439;9385.592161175742;9394.107559781809;9397.859032114524;9487.430754154773;9491.477968711788;4915.508449155056;4925.605951523869;4930.950690493121;4935.629827762932;4935.679180853233;4023.839046438168;4074.2869997750277;4342.131573685276;4668.346431499593;4744.95255047452;3667.2665466906724;3687.2809802088873;3749.4750734897134;3759.3984962405884;3828.8468461261796;1127.6617014895498;1128.9548418063187;1143.4340001699045;1166;1174.5595401724354;1027.2809033676456;1029.3875144289136;1034.1158309645145;1036.6734478639355;1044.3107549017764;6078.848028799315;6139.754409823647;6265.843353916189;6275.560710750204;6351.237851457855;429.8280687724935;429.97420154790814;434.57194663256666;437.964962802975;440.42304580998353;4312.137572485452;4397;4406.317020861771;4413.558644135561;4486.12520558488;10570.10154136907;10905;10934;10935.179861510418;10938.617148399768;10618.150547956146;10803.405812680221;10960.561577536968;10960.780784384428;10997.395143267036;8103.10865804761;8116.188381161836;8193.877091843628;8244.134365891616;8282.792930176794;6136.171616831849;6142.385761423822;6150.846228844314;6152.569320147547;6177.351378105414;10153.949230253802;10186.541605627617;10204.13264872494;10247.948760256151;10305.948470257601;10018.799624007625;10221.23340749432;10318.845217321896;10336.896631033593;10361.22290828206;6419.133416988647;7110.928890711027;7267.345938865527;7333.266673332624;7334.96332518334;8449.23956843887;8535.189157030072;8581.742547723577;8598.39811213209;8606.698765543177;7643.617819108911;7787.844243115219;7836.843263134591;7848.882266765889;7986.321162701235;7592.354649854824;7612.80967975805;7659.617019149132;7667.616619169131;7770.572618506037;6889.035535025;6952.513324067267;6984.860302794017;6987.580745155104;6988.126484189476;5201.505856943584;5247.1079916415065;5252.147815414557;5328.333958255218;5385.784568617368;5417.620766546462;5425.457454254543;5559.416261292506;5625.943740562542;5643.717814109196 07:26:52 INFO - PROCESS | 5419 | |4;prototype.html;328.72222971589014;332.94622519725067;338.8344096308698;340.59979524059224;342.05592564521913;5342.076852333157;5347.94104269856;5398.2982212312445;5403.297571315733;5409.269748583945;5264.710440925747;5286.550643195333;5293.8941221175555;5297.867553311169;5305.310309659749;3838.405047217686;3933.7836418997017;4038.9596104039024;4063.9187216255805;4109.630133288004;4082.2243773683053;4089.5705950875176;4113.115680128772;4113.156802855422;4128.731632443896;4071.837126514936;4076.347784354504;4084.6732261419165;4093.099518106012;4099.467069281004;3890.9027274318228;3994.840206391741;4074.2869997750277;4080;4110.527289361732;3529.3117842020815;3565.1978304881454;3583.33708263972;3601.3697602919647;3616.5895300832694;4993.976234871842;5056.974715126437;5060.139776238048;5064.696118232918;5074.5432911037815;4464.263396539567;4646.186917289495;4680.555347242007;4681.227597446417;4689.859304220879;5456.554013186509;5479.53423958964;5486.725663716838;5494.203340515643;5503.3395992480755;3951.644352008333;4013.9397909031386;4027.7180597358197;4043.3530635098537;4054.6350828425584;5491.807786727485;5719.342275638313;5730.426957304237;5747.827565173052;5765.4811067004175;4094.7101662976065;4110.23960567296;4113.958860411358;4118.629323360852;4144.212599606065;4166.562560901846;4201.852935147316;4204.5375008749015;4206.789660516962;4214.157168566299;4627.8843028923875;4628.722276663411;4750.952490475051;4751.40607424072;4810.7113573185725;5559.833205003856;5583.720813959286;5586.966411213938;5596.636218645775;5634.661615429633;1416.164462966834;1424.4017512644714;1426.6019301084787;1436.7844823276382;1437.590286768287;919.4713040002025;941.355171707369;956.3353469338742;959.5442164971582;972.4165500699665;5282.947170528322;5428.75570599324;5448.509634132947;5468.808591699271;5474.39781624021;5660.433956604306;5665.592123347561;5665.971670141623;5679.204911312419;5697.003024470701;5267.394249661338;5373.167159090347;5419.972900135553;5455.536279416215;5478.890422191614;3022.9395412091635;3024.4555979923384;3037.5595538647212;3042.361104168105;3049.5273232648974;5811.651300921958;5826.2134611827705;5857.209276747584;5937.921727395464;5950.8809823803285;5542.584306177053;5711.6001879868845;5756.597038207369;5819.79630712923;5827.242458480455;5851.853703657443;5853.356130825606;5882.911756323659;5906.586538942232;5947.910781338283;5378.946210537844;5672.432756724294;5683.829485115453;5721.57088218377;5729.512991395612;5677.630953987978;5695.316562012585;5704.545340938034;5713.714314284352;5729.341125770589;5973.253343332083;6004.609700369462;6010.819675409744;6011.609245399035;6025.969870150621;3868.574456809805;3943.4676318697757;3953.3081710701085;3966.801659916935;3986.4219688145636;5707.286589176353;5717.685527295872;5752.856178595569;5779.537636988946;5803.303603567599;5446.972765136149;5594.216809646571;5601.271834661468;5608.327000759935;5637.830865074055;5578.019802969888;5583.860403489945;5598.804041858515;5628.352739434854;5630.577706671934;5317.548008419328;5476.726163691879;5522.337319521683;5558.194061861089;5640.294963129609;5482.945170548243;5616.6068375213345;5620.494155526022;5626.240457538343;5631.7184140793615;5482.616216864782;5485.945140548703;5507.449255074461;5537.058700021086;5574.358948720949 07:26:52 INFO - PROCESS | 5419 | |5;yui.html;733;794.3486341200218;828.6602492977877;831.4720152703031;844.6030365728105;14766.926165369172;15213.163276019843;15228.543143705692;15303.846961530382;15341;13714.519991800289;13903.513377031806;13915.443382264722;13945.093568918013;14330.068545544558;670.828938620651;688.4526801193039;688.9793306200797;812.0904586862707;823.2138307915956;684.7124207832697;789.743333416639;811.3671336357651;812.9065157506874;821.8397412504564;859.2138193552892;864.7405778266526;867.7223288547667;868.4789126524066;868.9131086891292;701.2146396036471;864.6152462154344;864.8789169516273;864.9870251946226;866.2550206822159;604.5949214026568;624.4504835744561;625.2590680044117;625.8247690646626;626.3830127324582;13489.190648561118;13530.323483825769;13543.45826166952;13545.864541354558;13553;13019.544315948897;13412.530561430402;13431.932840335834;13585;13614.795778063337;11958.820617690742;12159.209651372632;12165.20926139807;12299.446524906401;12480;4351.0862718829085;4394.538573449774;4463.709858859196;4534.523874993111;4564.977175114103;57215.427845721846;57747.422525775044;58772.118418224185;58921.705391473195;59184.408155918754;10757.193210509244;10909.18181136418;10998.450077496092;11031.282966607145;11154.442277886073;19174.13716382766;19211.135498902582;19229.4231173065;19250.903745481184;19254.61490770177;8056.919430805617;8108.716194933267;8189.50862948225;8194.713185038496;8239.340852731768;4171.453294940849;4252;4254.106637606075;4418.779061046935;4465.24090904547;3354;3437.6218615952225;3445.7415693823064;3446;3451.050960985699;600.906859436788;613.1416017575341;617.305531277313;624.1293395712955;625.293418437163;606.3814908793006;632.2855173653742;672.3444641474523;715.5527795128045;724.6304384763808;8988.910110898807;9428.90571094294;9446.102620251066;9528.380655257386;9585.808283834283;527.7651445106967;621.4748537485817;672.9125213722283;715.1989771456002;720.7441358317826;4297.8495752648505;4346;4427.335899615019;4497.460304763384;4565.429321334833;68295.65852170707;68948.65525672339;70672;71199;71227.2877271231;58534.707326463096;59724.70137649371;60436;60778.78442431126;61725.60509171949;47532;48367.75816120897;49380.753096234286;57005.42994570084;58233.41766582365;9599.664011759554;9854.11312981835;9869.161121304769;9990.850137247802;10038.146757525692;36166.63833361633;36444.27111457809;37382.813085935486;37713.24573508569;38096.809515953355;46102.769486153695;49705.76912500676;50187.247191291426;50234.24648630201;50477;11004.559817607525;11174.832377514507;12331.50673973031;12617.242965422103;12923.612291631267;12150.598407551623;12496.12527123129;12571;12824;12921.418536165707;11236.83144752813;12219.572314968933;12891.419886105336;13103.60689179326;13160.104776949056;13156.144850584682;13188.736225275632;13234.139780914209;13362.331883405985;13570.032345310072;12792.808107878203;13011.21932684042;13469.595912122651;13535.932320338728;13800.964927630266;10590.89409105899;10750.677479675622;11173;11218.439078045902;11278.210525263154;10939.945300273448;10979.39613321275;11158.49786759614;11164.106871450427;11210.55157793679 07:26:52 INFO - PROCESS | 5419 | __end_tp_report 07:26:52 INFO - PROCESS | 5419 | __start_cc_report 07:26:52 INFO - PROCESS | 5419 | _x_x_mozilla_cycle_collect,851 07:26:52 INFO - PROCESS | 5419 | __end_cc_report 07:26:52 INFO - PROCESS | 5419 | __startTimestamp1464186412935__endTimestamp 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | ------- Summary: start ------- 07:26:52 INFO - PROCESS | 5419 | Number of tests: 6 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#0] dojo.html Cycles:165 Average:5243.28 Median:5452.40 stddev:594.65 (10.9%) stddev-sans-first:571.56 07:26:52 INFO - PROCESS | 5419 | Values: 3072.2 3079.4 3103.5 3113.9 3141.1 5098.5 5194.8 5219.0 5295.8 5302.5 5131.4 5212.8 5221.9 5226.5 5267.4 4671.2 4717.2 4751.9 4760.9 4905.1 4753.9 4793.0 4805.1 4811.7 4832.2 4647.1 4697.4 4699.1 4709.8 4763.5 4714.6 4724.5 4784.7 4795.6 4825.2 4594.8 4754.1 4759.7 4760.4 4807.7 5138.2 5185.7 5197.6 5246.3 5263.0 5628.0 5681.7 5705.3 5708.5 5715.3 5456.2 5587.9 5613.0 5747.2 5753.4 5313.9 5345.7 5356.2 5363.9 5369.0 5837.1 5862.7 5869.1 5888.9 5889.4 5345.6 5462.7 5513.4 5540.6 5634.5 5662.1 5662.3 5724.5 5725.4 5730.9 5611.0 5613.2 5627.9 5631.4 5644.5 5440.6 5609.5 5640.2 5665.0 5696.6 4349.3 4350.5 4361.8 4369.6 4382.1 3804.3 3891.6 3900.5 3942.3 3953.7 5362.1 5434.8 5439.4 5450.3 5452.4 5665.6 5690.9 5702.4 5708.4 5762.8 5396.3 5435.5 5441.2 5455.6 5456.4 4772.0 4773.6 4881.0 4881.5 4892.7 5818.2 5829.7 5832.4 5836.7 5841.6 5546.1 5628.6 5630.2 5639.6 5639.7 5779.0 5782.2 5804.6 5863.1 5866.1 5517.3 5532.8 5540.6 5541.9 5552.5 5429.3 5637.4 5645.5 5652.4 5657.8 5420.9 5429.5 5446.5 5479.4 5491.0 5448.3 5470.7 5475.5 5492.5 5506.1 5239.0 5397.7 5462.2 5465.0 5506.3 5573.0 5662.5 5669.3 5669.8 5670.3 5425.5 5465.9 5466.2 5474.1 5502.2 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#1] ext.html Cycles:180 Average:62273.48 Median:3581.95 stddev:125416.10 (3501.3%) stddev-sans-first:125682.43 07:26:52 INFO - PROCESS | 5419 | Values: 594.9 621.2 629.9 637.4 640.2 32573.7 42807.6 43659.1 43845.0 43933.6 45387.8 45885.8 45908.0 45941.1 45947.0 7805.4 8656.7 8874.1 8884.7 10123.3 10091.5 10502.0 10561.3 10569.9 10578.2 10499.8 10567.2 10576.1 10577.6 10591.4 8005.4 10246.5 10536.8 10595.6 10611.2 10315.3 10340.6 10353.2 10404.1 10457.0 41409.0 42222.2 42240.2 42346.4 42422.4 3233.0 3501.7 3504.6 3538.5 3625.4 30726.8 32262.4 32707.8 32802.0 32832.5 4331.0 4343.3 4517.2 4524.6 4545.0 337743.0 338356.0 338671.0 338960.0 339268.0 60460.0 60537.1 60720.1 60858.0 60935.1 62929.7 63610.0 63665.0 63725.4 63781.4 16512.1 16979.4 16983.8 16991.0 17011.6 12184.3 12236.9 12242.9 12445.1 12455.0 19136.2 19690.3 19728.2 19839.4 19853.8 6178.4 7015.0 7167.7 7169.5 7215.4 1018.2 1044.9 1064.4 1173.0 1221.8 30751.6 32229.5 32429.4 32520.0 32563.5 1088.2 1092.8 1115.9 1128.8 1132.6 16425.8 16636.1 16958.9 16992.8 17057.8 563071.0 569494.0 569808.0 569880.0 570683.0 56897.4 58068.0 58280.1 58458.7 58642.0 1295.7 1375.7 1391.1 1402.5 1403.4 29752.1 30776.7 30997.0 31275.5 31293.8 50050.5 50523.5 50699.2 50727.5 50764.7 476048.0 479947.0 480874.0 481481.0 482784.0 24205.5 24883.8 27138.2 27627.9 27925.3 45651.1 47243.3 48354.8 48567.3 48817.5 39950.4 39962.4 40455.4 40839.6 41340.4 40567.0 40926.2 41036.4 41446.4 41538.0 41088.4 41354.4 41657.0 41727.8 41842.0 34485.5 36265.6 36612.6 36842.4 37088.0 28267.3 28451.0 28514.0 28709.4 28823.9 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#2] jquery.html Cycles:180 Average:28739.58 Median:15393.12 stddev:74704.96 (485.3%) stddev-sans-first:74884.20 07:26:52 INFO - PROCESS | 5419 | Values: 390.3 395.6 402.9 405.2 424.5 13675.6 17682.3 17882.0 19318.7 19385.1 18000.1 18283.5 18864.4 18911.6 19789.3 5656.8 5682.4 5814.3 5819.8 5819.9 4158.4 5640.5 5754.3 5763.1 6113.6 6365.4 6453.5 6458.6 6478.0 6480.9 6270.5 6304.7 6322.6 6448.7 6451.2 5525.3 5692.6 5706.7 5713.3 5730.9 22772.9 23050.9 23070.0 23760.5 24954.6 2404.4 2479.5 2509.1 2911.5 3356.0 14324.3 15047.7 15354.0 15596.8 15829.4 1867.2 2068.7 2199.6 2245.2 2374.7 90665.0 91833.5 94465.5 96169.5 100715.0 17825.4 18042.4 18264.0 18369.7 18609.2 25973.0 27874.7 32029.4 32093.0 32101.4 9947.4 10128.6 10148.3 10162.6 10311.6 8289.0 8401.2 8433.7 8525.0 8615.2 8970.5 8985.9 9079.2 9080.7 9104.2 3526.0 3570.3 3582.0 3613.2 3636.6 960.8 1021.9 1040.6 1073.2 1110.0 18251.7 18938.4 18947.6 19091.2 19249.2 1011.2 1026.0 1066.2 1069.1 1087.2 10455.2 10798.8 10817.2 10923.9 10965.6 435920.0 439292.0 439396.0 470649.0 475612.0 56729.7 78072.6 89956.0 90178.0 90225.1 968.3 1003.5 1003.5 1007.4 1021.8 16538.5 16664.5 16951.6 17101.7 17353.9 32509.0 33013.0 36036.0 38594.2 38816.8 50582.5 54622.0 55204.4 55746.2 55884.4 8094.3 8462.5 8529.4 8608.5 8612.0 12733.5 13519.6 13653.8 13788.4 13941.7 11628.5 11794.5 11909.0 12085.1 12263.4 10957.9 11495.8 11665.4 11672.2 11909.0 9255.4 11507.7 12266.2 12450.2 12714.9 8523.1 8638.2 8750.3 8791.6 8990.5 8878.1 11518.9 11704.6 12233.8 12262.4 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#3] mootools.html Cycles:180 Average:5687.73 Median:2388.35 stddev:3288.39 (137.7%) stddev-sans-first:3280.97 07:26:52 INFO - PROCESS | 5419 | Values: 1285.0 1487.2 1520.1 1662.7 1829.3 8090.9 8539.7 8573.0 8721.8 8735.7 8407.2 8606.4 8609.5 8612.0 8628.7 2218.1 2235.4 2241.0 2242.8 2243.7 2244.8 2249.7 2309.8 2313.0 2321.4 2265.5 2268.1 2291.6 2293.7 2295.6 2111.6 2115.7 2131.5 2132.5 2133.9 2082.9 2084.1 2094.4 2096.4 2097.3 8423.5 8444.8 8483.9 8495.8 8708.2 4876.9 4971.2 4972.8 4974.5 4977.5 3078.7 3134.6 3151.9 3174.3 3191.1 1026.2 1051.3 1072.9 1079.6 1107.9 11878.4 12067.0 12070.6 12072.6 12074.1 4159.9 4176.6 4179.6 4211.9 4312.8 9385.6 9394.1 9397.9 9487.4 9491.5 4915.5 4925.6 4931.0 4935.6 4935.7 4023.8 4074.3 4342.1 4668.3 4745.0 3667.3 3687.3 3749.5 3759.4 3828.8 1127.7 1129.0 1143.4 1166.0 1174.6 1027.3 1029.4 1034.1 1036.7 1044.3 6078.8 6139.8 6265.8 6275.6 6351.2 429.8 430.0 434.6 438.0 440.4 4312.1 4397.0 4406.3 4413.6 4486.1 10570.1 10905.0 10934.0 10935.2 10938.6 10618.2 10803.4 10960.6 10960.8 10997.4 8103.1 8116.2 8193.9 8244.1 8282.8 6136.2 6142.4 6150.8 6152.6 6177.4 10153.9 10186.5 10204.1 10247.9 10305.9 10018.8 10221.2 10318.8 10336.9 10361.2 6419.1 7110.9 7267.3 7333.3 7335.0 8449.2 8535.2 8581.7 8598.4 8606.7 7643.6 7787.8 7836.8 7848.9 7986.3 7592.4 7612.8 7659.6 7667.6 7770.6 6889.0 6952.5 6984.9 6987.6 6988.1 5201.5 5247.1 5252.1 5328.3 5385.8 5417.6 5425.5 5559.4 5625.9 5643.7 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#4] prototype.html Cycles:180 Average:4681.78 Median:5424.36 stddev:1386.15 (25.6%) stddev-sans-first:1350.98 07:26:52 INFO - PROCESS | 5419 | Values: 328.7 332.9 338.8 340.6 342.1 5342.1 5347.9 5398.3 5403.3 5409.3 5264.7 5286.6 5293.9 5297.9 5305.3 3838.4 3933.8 4039.0 4063.9 4109.6 4082.2 4089.6 4113.1 4113.2 4128.7 4071.8 4076.3 4084.7 4093.1 4099.5 3890.9 3994.8 4074.3 4080.0 4110.5 3529.3 3565.2 3583.3 3601.4 3616.6 4994.0 5057.0 5060.1 5064.7 5074.5 4464.3 4646.2 4680.6 4681.2 4689.9 5456.6 5479.5 5486.7 5494.2 5503.3 3951.6 4013.9 4027.7 4043.4 4054.6 5491.8 5719.3 5730.4 5747.8 5765.5 4094.7 4110.2 4114.0 4118.6 4144.2 4166.6 4201.9 4204.5 4206.8 4214.2 4627.9 4628.7 4751.0 4751.4 4810.7 5559.8 5583.7 5587.0 5596.6 5634.7 1416.2 1424.4 1426.6 1436.8 1437.6 919.5 941.4 956.3 959.5 972.4 5282.9 5428.8 5448.5 5468.8 5474.4 5660.4 5665.6 5666.0 5679.2 5697.0 5267.4 5373.2 5420.0 5455.5 5478.9 3022.9 3024.5 3037.6 3042.4 3049.5 5811.7 5826.2 5857.2 5937.9 5950.9 5542.6 5711.6 5756.6 5819.8 5827.2 5851.9 5853.4 5882.9 5906.6 5947.9 5378.9 5672.4 5683.8 5721.6 5729.5 5677.6 5695.3 5704.5 5713.7 5729.3 5973.3 6004.6 6010.8 6011.6 6026.0 3868.6 3943.5 3953.3 3966.8 3986.4 5707.3 5717.7 5752.9 5779.5 5803.3 5447.0 5594.2 5601.3 5608.3 5637.8 5578.0 5583.9 5598.8 5628.4 5630.6 5317.5 5476.7 5522.3 5558.2 5640.3 5482.9 5616.6 5620.5 5626.2 5631.7 5482.6 5485.9 5507.4 5537.1 5574.4 07:26:52 INFO - PROCESS | 5419 | 07:26:52 INFO - PROCESS | 5419 | [#5] yui.html Cycles:180 Average:15617.94 Median:4464.48 stddev:18712.53 (419.1%) stddev-sans-first:18731.64 07:26:52 INFO - PROCESS | 5419 | Values: 733.0 794.3 828.7 831.5 844.6 14766.9 15213.2 15228.5 15303.8 15341.0 13714.5 13903.5 13915.4 13945.1 14330.1 670.8 688.5 689.0 812.1 823.2 684.7 789.7 811.4 812.9 821.8 859.2 864.7 867.7 868.5 868.9 701.2 864.6 864.9 865.0 866.3 604.6 624.5 625.3 625.8 626.4 13489.2 13530.3 13543.5 13545.9 13553.0 13019.5 13412.5 13431.9 13585.0 13614.8 11958.8 12159.2 12165.2 12299.4 12480.0 4351.1 4394.5 4463.7 4534.5 4565.0 57215.4 57747.4 58772.1 58921.7 59184.4 10757.2 10909.2 10998.5 11031.3 11154.4 19174.1 19211.1 19229.4 19250.9 19254.6 8056.9 8108.7 8189.5 8194.7 8239.3 4171.5 4252.0 4254.1 4418.8 4465.2 3354.0 3437.6 3445.7 3446.0 3451.1 600.9 613.1 617.3 624.1 625.3 606.4 632.3 672.3 715.6 724.6 8988.9 9428.9 9446.1 9528.4 9585.8 527.8 621.5 672.9 715.2 720.7 4297.8 4346.0 4427.3 4497.5 4565.4 68295.7 68948.7 70672.0 71199.0 71227.3 58534.7 59724.7 60436.0 60778.8 61725.6 47532.0 48367.8 49380.8 57005.4 58233.4 9599.7 9854.1 9869.2 9990.9 10038.1 36166.6 36444.3 37382.8 37713.2 38096.8 46102.8 49705.8 50187.2 50234.2 50477.0 11004.6 11174.8 12331.5 12617.2 12923.6 12150.6 12496.1 12571.0 12824.0 12921.4 11236.8 12219.6 12891.4 13103.6 13160.1 13156.1 13188.7 13234.1 13362.3 13570.0 12792.8 13011.2 13469.6 13535.9 13801.0 10590.9 10750.7 11173.0 11218.4 11278.2 10939.9 10979.4 11158.5 11164.1 11210.6 07:26:52 INFO - PROCESS | 5419 | -------- Summary: end -------- 07:26:52 INFO - PROCESS | 5419 | 07:26:53 INFO - TEST-INFO | 5419: exit 0 07:26:53 INFO - TEST-OK | dromaeo_css | took 1113122ms 07:26:53 INFO - TEST-START | kraken 07:26:53 INFO - operating with platform_type : linux_ 07:26:53 INFO - Initialising browser for kraken test... 07:26:53 INFO - TEST-INFO | started process 5598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBo82k/profile http://localhost:60581/getInfo.html) 07:26:58 INFO - PROCESS | 5598 | __metrics Screen width/height:1600/1200 07:26:58 INFO - PROCESS | 5598 | colorDepth:24 07:26:58 INFO - PROCESS | 5598 | Browser inner width/height: 1024/697 07:26:58 INFO - PROCESS | 5598 | __metrics 07:26:59 ERROR - PROCESS | 5598 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:27:00 INFO - TEST-INFO | 5598: exit 0 07:27:00 INFO - Browser initialized. 07:27:00 INFO - Running cycle 1/1 for kraken test... 07:27:00 INFO - TEST-INFO | started process 5680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBo82k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:12 INFO - PROCESS | 5680 | RSS: Main: 154681344 07:27:12 INFO - PROCESS | 5680 | 07:27:14 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60581/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:15 INFO - PROCESS | 5680 | RSS: Main: 210735104 07:27:15 INFO - PROCESS | 5680 | 07:27:18 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60581/tests/kraken/driver.html?testName=audio-dft) 07:27:18 INFO - PROCESS | 5680 | RSS: Main: 199639040 07:27:18 INFO - PROCESS | 5680 | 07:27:21 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60581/tests/kraken/driver.html?testName=audio-fft) 07:27:22 INFO - PROCESS | 5680 | RSS: Main: 267669504 07:27:22 INFO - PROCESS | 5680 | 07:27:24 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60581/tests/kraken/driver.html?testName=audio-oscillator) 07:27:25 INFO - PROCESS | 5680 | RSS: Main: 176758784 07:27:25 INFO - PROCESS | 5680 | 07:27:27 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:27 INFO - PROCESS | 5680 | RSS: Main: 180801536 07:27:27 INFO - PROCESS | 5680 | 07:27:31 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60581/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:31 INFO - PROCESS | 5680 | RSS: Main: 216887296 07:27:31 INFO - PROCESS | 5680 | 07:27:35 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60581/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:35 INFO - PROCESS | 5680 | RSS: Main: 217620480 07:27:35 INFO - PROCESS | 5680 | 07:27:38 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60581/tests/kraken/driver.html?testName=json-parse-financial) 07:27:38 INFO - PROCESS | 5680 | RSS: Main: 218787840 07:27:38 INFO - PROCESS | 5680 | 07:27:40 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:41 INFO - PROCESS | 5680 | RSS: Main: 205197312 07:27:41 INFO - PROCESS | 5680 | 07:27:42 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:43 INFO - PROCESS | 5680 | RSS: Main: 207163392 07:27:43 INFO - PROCESS | 5680 | 07:27:45 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:46 INFO - PROCESS | 5680 | RSS: Main: 218243072 07:27:46 INFO - PROCESS | 5680 | 07:27:48 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:49 INFO - PROCESS | 5680 | RSS: Main: 227659776 07:27:49 INFO - PROCESS | 5680 | 07:27:52 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:52 INFO - PROCESS | 5680 | RSS: Main: 223813632 07:27:52 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | Cycle 1(1): loaded http://localhost:60581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60581/tests/kraken/driver.html?testName=ai-astar) 07:27:54 INFO - PROCESS | 5680 | RSS: Main: 269565952 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | __start_tp_report 07:27:54 INFO - PROCESS | 5680 | _x_x_mozilla_page_load 07:27:54 INFO - PROCESS | 5680 | _x_x_mozilla_page_load_details 07:27:54 INFO - PROCESS | 5680 | |i|pagename|runs| 07:27:54 INFO - PROCESS | 5680 | |0;ai-astar;111;109;111;111;112;112;113;111;111;110 07:27:54 INFO - PROCESS | 5680 | |1;audio-beat-detection;153;125;127;205;125;125;163;127;166;125 07:27:54 INFO - PROCESS | 5680 | |2;audio-dft;160;161;159;162;161;159;162;162;161;160 07:27:54 INFO - PROCESS | 5680 | |3;audio-fft;75;75;75;111;74;76;74;77;111;75 07:27:54 INFO - PROCESS | 5680 | |4;audio-oscillator;83;83;123;83;83;84;123;84;84;119 07:27:54 INFO - PROCESS | 5680 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;117 07:27:54 INFO - PROCESS | 5680 | |6;imaging-darkroom;146;148;146;146;147;147;146;146;146;146 07:27:54 INFO - PROCESS | 5680 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;96;95 07:27:54 INFO - PROCESS | 5680 | |8;json-parse-financial;56;56;54;56;60;56;57;71;53;54 07:27:54 INFO - PROCESS | 5680 | |9;json-stringify-tinderbox;63;63;62;62;63;62;62;62;68;62 07:27:54 INFO - PROCESS | 5680 | |10;stanford-crypto-aes;79;80;80;80;81;87;84;86;79;86 07:27:54 INFO - PROCESS | 5680 | |11;stanford-crypto-ccm;122;120;120;122;121;117;128;129;165;123 07:27:54 INFO - PROCESS | 5680 | |12;stanford-crypto-pbkdf2;170;166;166;161;160;162;166;171;163;161 07:27:54 INFO - PROCESS | 5680 | |13;stanford-crypto-sha256-iterative;63;66;65;62;64;63;66;63;63;62 07:27:54 INFO - PROCESS | 5680 | __end_tp_report 07:27:54 INFO - PROCESS | 5680 | __start_cc_report 07:27:54 INFO - PROCESS | 5680 | _x_x_mozilla_cycle_collect,1661 07:27:54 INFO - PROCESS | 5680 | __end_cc_report 07:27:54 INFO - PROCESS | 5680 | __startTimestamp1464186474683__endTimestamp 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | ------- Summary: start ------- 07:27:54 INFO - PROCESS | 5680 | Number of tests: 14 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 07:27:54 INFO - PROCESS | 5680 | Values: 111.0 109.0 111.0 111.0 112.0 112.0 113.0 111.0 111.0 110.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:140.00 stddev:27.22 (19.4%) stddev-sans-first:28.68 07:27:54 INFO - PROCESS | 5680 | Values: 153.0 125.0 127.0 205.0 125.0 125.0 163.0 127.0 166.0 125.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 07:27:54 INFO - PROCESS | 5680 | Values: 160.0 161.0 159.0 162.0 161.0 159.0 162.0 162.0 161.0 160.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.15 (20.2%) stddev-sans-first:15.84 07:27:54 INFO - PROCESS | 5680 | Values: 75.0 75.0 75.0 111.0 74.0 76.0 74.0 77.0 111.0 75.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:83.00 stddev:18.51 (22.3%) stddev-sans-first:19.12 07:27:54 INFO - PROCESS | 5680 | Values: 83.0 83.0 123.0 83.0 83.0 84.0 123.0 84.0 84.0 119.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:27:54 INFO - PROCESS | 5680 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:27:54 INFO - PROCESS | 5680 | Values: 146.0 148.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:27:54 INFO - PROCESS | 5680 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.00 stddev:5.19 (9.3%) stddev-sans-first:5.48 07:27:54 INFO - PROCESS | 5680 | Values: 56.0 56.0 54.0 56.0 60.0 56.0 57.0 71.0 53.0 54.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:1.85 (3.0%) stddev-sans-first:1.96 07:27:54 INFO - PROCESS | 5680 | Values: 63.0 63.0 62.0 62.0 63.0 62.0 62.0 62.0 68.0 62.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:3.19 (3.9%) stddev-sans-first:3.17 07:27:54 INFO - PROCESS | 5680 | Values: 79.0 80.0 80.0 80.0 81.0 87.0 84.0 86.0 79.0 86.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:122.50 stddev:13.94 (11.4%) stddev-sans-first:14.68 07:27:54 INFO - PROCESS | 5680 | Values: 122.0 120.0 120.0 122.0 121.0 117.0 128.0 129.0 165.0 123.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:166.00 stddev:3.84 (2.3%) stddev-sans-first:3.54 07:27:54 INFO - PROCESS | 5680 | Values: 170.0 166.0 166.0 161.0 160.0 162.0 166.0 171.0 163.0 161.0 07:27:54 INFO - PROCESS | 5680 | 07:27:54 INFO - PROCESS | 5680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.49 (2.4%) stddev-sans-first:1.56 07:27:54 INFO - PROCESS | 5680 | Values: 63.0 66.0 65.0 62.0 64.0 63.0 66.0 63.0 63.0 62.0 07:27:54 INFO - PROCESS | 5680 | -------- Summary: end -------- 07:27:54 INFO - PROCESS | 5680 | 07:27:55 INFO - TEST-INFO | 5680: exit 0 07:27:55 INFO - TEST-OK | kraken | took 61986ms 07:27:55 INFO - SUITE-END | took 1175s 07:27:55 INFO - Completed test suite (00:19:35) 07:27:55 INFO - javascript benchmark 07:27:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.201227680803, 3079.3687294104698, 3103.4568950433677, 3113.891013814517, 3141.104785136237, 5098.515641014107, 5194.818181363653, 5218.982298451799, 5295.841124766258, 5302.4697530247, 5131.435542090367, 5212.817551385693, 5221.921671174935, 5226.4512226216175, 5267.446918073604, 4671.182543054969, 4717.245240761479, 4751.857444276678, 4760.90478190436, 4905.0925578767865, 4753.928691069636, 4793.041391721669, 4805.111054454919, 4811.663183577151, 4832.226843705008, 4647.093816705744, 4697.412823397075, 4699.130660827758, 4709.764511774431, 4763.547462990993, 4714.599259062949, 4724.480307166209, 4784.712917224978, 4795.640326975491, 4825.1555977703765, 4594.770261486912, 4754.072955773626, 4759.714417134983, 4760.357351757503, 4807.687500312469, 5138.152204886189, 5185.714785686786, 5197.558207552363, 5246.265522826808, 5262.973685131588, 5627.971860140714, 5681.687507187145, 5705.258316418881, 5708.514776244025, 5715.2855893013375, 5456.181572764117, 5587.8603034924045, 5613.045782217033, 5747.1666608341975, 5753.395893431171, 5313.867153321198, 5345.679259244458, 5356.223347614574, 5363.865903352408, 5369.033573956686, 5837.124431335334, 5862.677552734641, 5869.090291004901, 5888.852778680482, 5889.352171261158, 5345.599080069011, 5462.672239665553, 5513.42109078549, 5540.556755459635, 5634.464725851038, 5662.094064949588, 5662.320521537442, 5724.484796368263, 5725.370209276976, 5730.856728581735, 5610.971945140248, 5613.186088017296, 5627.915581266284, 5631.352394474606, 5644.520215781622, 5440.591955603346, 5609.523190528851, 5640.182173584889, 5664.971675141598, 5696.629719068247, 4349.28236840924, 4350.543192964757, 4361.781910904442, 4369.628581570539, 4382.05785756064, 3804.334241507725, 3891.5719270880745, 3900.473436086149, 3942.290387730236, 3953.723239373216, 5362.088444964365, 5434.809781657623, 5439.401665816757, 5450.264214331094, 5452.40023597404, 5665.575081868877, 5690.943090569124, 5702.372738998707, 5708.372079071299, 5762.798302059407, 5396.2984811974975, 5435.456454354533, 5441.183822426588, 5455.645383050169, 5456.399796022434, 4772.0, 4773.618110551148, 4881.0, 4881.4630390657, 4892.657513973988, 5818.214541036906, 5829.7376618052285, 5832.445917637902, 5836.678982655994, 5841.591088623755, 5546.057170280981, 5628.634138780966, 5630.18362337467, 5639.6334238274385, 5639.7180140993605, 5778.971105144616, 5782.190493331022, 5804.564657650778, 5863.091220860773, 5866.061430171152, 5517.337919449692, 5532.778688852401, 5540.584456165723, 5541.944580554143, 5552.500824777207, 5429.267048948342, 5637.43625637433, 5645.491905728504, 5652.378238393691, 5657.773689052392, 5420.9186862197885, 5429.457054294539, 5446.509814116748, 5479.424660410599, 5491.039068162976, 5448.346198456211, 5470.671759694431, 5475.4524547544925, 5492.47821456961, 5506.091494903296, 5238.978399212117, 5397.676139431646, 5462.235287059735, 5465.043617367024, 5506.311711036121, 5573.0, 5662.5469962402085, 5669.34802497718, 5669.801556945652, 5670.291213598301, 5425.511703946664, 5465.934142842108, 5466.234727138283, 5474.069408200536, 5502.202180683858], "value": 5203.7206532108075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.9464548190665, 621.1707370660168, 629.8645791154902, 637.4422380417134, 640.2477089419928, 32573.67426325739, 42807.57192428079, 43659.12681746371, 43845.0, 43933.56066439335, 45387.77306113465, 45885.7705711471, 45908.0, 45941.081178376415, 45947.0, 7805.4145939054515, 8656.697015604455, 8874.112588741107, 8884.689035883745, 10123.341982771133, 10091.545880435362, 10502.0, 10561.313514621563, 10569.947150264237, 10578.206634502405, 10499.790004199911, 10567.15462762981, 10576.10103141234, 10577.629782957598, 10591.417472039035, 8005.359571234317, 10246.48767561619, 10536.841947370758, 10595.629152979609, 10611.204159687977, 10315.277930544866, 10340.638077667245, 10353.223508236912, 10404.063634272876, 10457.0, 41409.0, 42222.155556888996, 42240.155196896194, 42346.364804527955, 42422.36366454505, 3233.0, 3501.6848483636595, 3504.6144924058335, 3538.486919396699, 3625.4199328107375, 30726.84636576803, 32262.354752904812, 32707.836460817543, 32802.0, 32832.50751238733, 4330.950561225264, 4343.305071188626, 4517.186906356855, 4524.61540769035, 4544.954550454486, 337743.0, 338356.0, 338671.0, 338960.0, 339268.0, 60460.0, 60537.09194362088, 60720.089198662055, 60858.0, 60935.08597371043, 62929.68535157386, 63610.0, 63665.0, 63725.40686482875, 63781.36218637754, 16512.09183494895, 16979.40572079996, 16983.83016169847, 16991.0, 17011.574710632332, 12184.329861857506, 12236.858549753757, 12242.877571224351, 12445.128840981226, 12455.0, 19136.234550618097, 19690.31083912056, 19728.210871565265, 19839.404817855488, 19853.801461985197, 6178.41305076017, 7014.964925175342, 7167.713291468387, 7169.462290328246, 7215.386692131227, 1018.2057994764095, 1044.9216308776872, 1064.3826580583243, 1173.0322483950774, 1221.7984032634693, 30751.61811495804, 32229.51655725166, 32429.35141297161, 32520.0, 32563.51154732681, 1088.2200183018851, 1092.759592889563, 1115.9274647147909, 1128.774245150973, 1132.5866058888446, 16425.83574164267, 16636.08501532427, 16958.915205423895, 16992.830071699373, 17057.829421705872, 563071.0, 569494.0, 569808.0, 569880.0, 570683.0, 56897.43102569004, 58068.0, 58280.12579811221, 58458.707706461195, 58642.0, 1295.6825577733516, 1375.7179778145455, 1391.0679844504207, 1402.4530433131088, 1403.39653948803, 29752.082487297488, 30776.69223307828, 30997.0, 31275.53086703747, 31293.8435307822, 50050.49949500604, 50523.49476505188, 50699.239511408094, 50727.492725072276, 50764.669709679954, 476048.0, 479947.0, 480874.0, 481481.0, 482784.0, 24205.51588968246, 24883.75116248887, 27138.200651908355, 27627.86186069057, 27925.301867452665, 45651.086978260915, 47243.291350630454, 48354.75822620864, 48567.27149092837, 48817.511824881294, 39950.40074398944, 39962.400563992145, 40455.381784728284, 40839.59160408358, 41340.37989430221, 40567.0, 40926.181476370904, 41036.38445423261, 41446.378304324855, 41538.0, 41088.38367424431, 41354.37968430416, 41657.0, 41727.791361043, 41842.0, 34485.48271775875, 36265.637343627284, 36612.633873660925, 36842.44736328904, 37088.0, 28267.293317667223, 28451.0, 28514.0, 28709.42581148407, 28823.85588072046], "value": 20576.849853959848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.29162070841403, 395.5589517687779, 402.8992751812047, 405.1815333027285, 424.4863714904965, 13675.589732308023, 17682.292708291687, 17882.0, 19318.710219346704, 19385.12766925488, 18000.099995000262, 18283.451496455094, 18864.434066977978, 18911.62176756464, 19789.307374241904, 5656.773729050833, 5682.403347648499, 5814.302283725959, 5819.7672093116435, 5819.912701309484, 4158.4178215049915, 5640.464155905182, 5754.251947246873, 5763.106718458645, 6113.572049956505, 6365.395287447685, 6453.548251622365, 6458.644774537399, 6477.9676101619425, 6480.902786458183, 6270.529710271725, 6304.684765761694, 6322.589031712924, 6448.677566121675, 6451.161349024644, 5525.254090697745, 5692.6299790513485, 5706.686132262724, 5713.314402271712, 5730.856728581777, 22772.88613556938, 23050.884745576164, 23070.0, 23760.524789504114, 24954.625680614805, 2404.446977195237, 2479.454520005614, 2509.0591028364365, 2911.5195992661183, 3356.0, 14324.283785810669, 15047.699046019019, 15354.0, 15596.766048509282, 15829.445969391016, 1867.1691097461635, 2068.6690129579347, 2199.6480563109985, 2245.1692873636694, 2374.726906405751, 90665.0, 91833.54083229607, 94465.52767236189, 96169.5191524045, 100715.0, 17825.376111836023, 18042.368517101837, 18264.0, 18369.7244541332, 18609.162587683586, 25973.0, 27874.721252787618, 32029.359412811613, 32093.0, 32101.35797284041, 9947.353422027545, 10128.59485620567, 10148.289619726696, 10162.64430744935, 10311.587536498606, 8289.010637446969, 8401.15988401155, 8433.746987590383, 8524.95737521321, 8615.181557752003, 8970.506622135845, 8985.910140898508, 9079.182873541413, 9080.682176123804, 9104.180623743763, 3525.964740352615, 3570.285942811396, 3581.964180358163, 3613.1870329175727, 3636.581793093775, 960.8174446855076, 1021.8759364698772, 1040.5785656809005, 1073.1575713065206, 1109.9778004439866, 18251.72622410665, 18938.431847044336, 18947.62104757897, 19091.2363505461, 19249.23003079889, 1011.1607365886443, 1025.99487002566, 1066.2163309967168, 1069.1019543583427, 1087.217203613397, 10455.16358691303, 10798.838017429745, 10817.188710846718, 10923.890761092447, 10965.56137754497, 435920.0, 439292.0, 439396.0, 470649.0, 475612.0, 56729.71635141798, 78072.60963695146, 89956.0, 90178.0, 90225.09774902168, 968.2689569375218, 1003.4731765823001, 1003.5433877585681, 1007.4408703169811, 1021.8211812932856, 16538.50384488467, 16664.50006499807, 16951.576210594834, 17101.743473847655, 17353.91323043427, 32509.0, 33013.0, 36036.0, 38594.2281154381, 38816.80591597137, 50582.49417505778, 54622.0, 55204.44795552154, 55746.16380754373, 55884.44115558955, 8094.271515563628, 8462.492250464991, 8529.360297977553, 8608.526531040603, 8611.95694021526, 12733.490660373482, 13519.594412167256, 13653.79519307231, 13788.448462061806, 13941.651458713613, 11628.476718547854, 11794.52821887115, 11909.0, 12085.093617978511, 12263.448144833683, 10957.945210273898, 11495.77008459843, 11665.35840528779, 11672.182947193614, 11909.0, 9255.444673319622, 11507.712307192387, 12266.202696824677, 12450.194721765474, 12714.87285127137, 8523.147685231428, 8638.185980944072, 8750.299976001777, 8791.560421979004, 8990.505522196341, 8878.112188781328, 11518.884811151782, 11704.648860534198, 12233.816492752794, 12262.4481898313], "value": 10106.35426894956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.9550265740702, 1487.1746180869616, 1520.1259275916348, 1662.7339625659897, 1829.3231504343396, 8090.91909080909, 8539.658413663454, 8573.0, 8721.781955451117, 8735.650573977033, 8407.201315874998, 8606.397552171351, 8609.526476043815, 8612.00961889383, 8628.741137765877, 2218.134927378324, 2235.3629215673536, 2241.025154057982, 2242.7532971373216, 2243.719535058118, 2244.753077161511, 2249.707538020055, 2309.8383113182085, 2313.0, 2321.361625552978, 2265.5129147233342, 2268.0587556164173, 2291.6447950567604, 2293.7018187635585, 2295.6097463431174, 2111.5776844631137, 2115.650917598602, 2131.477787941956, 2132.4775430019668, 2133.8506304558687, 2082.875027498355, 2084.1038353507984, 2094.434502684282, 2096.3501314592527, 2097.2554743066144, 8423.452475589067, 8444.788880278042, 8483.872741908875, 8495.787605309855, 8708.17272359125, 4876.853694389174, 4971.1549036663855, 4972.801087956477, 4974.502549745032, 4977.477364876709, 3078.6921307869256, 3134.5925029745986, 3151.8739250430185, 3174.3016536361965, 3191.138392633976, 1026.2149455666422, 1051.3429106808244, 1072.9302595331278, 1079.5843600213896, 1107.9279846810011, 11878.40607969598, 12067.0, 12070.577529786504, 12072.577459788952, 12074.094442916816, 4159.9376009359885, 4176.561461046607, 4179.561146079618, 4211.915761684749, 4312.805923733439, 9385.592161175742, 9394.107559781809, 9397.859032114524, 9487.430754154773, 9491.477968711788, 4915.508449155056, 4925.605951523869, 4930.950690493121, 4935.629827762932, 4935.679180853233, 4023.839046438168, 4074.2869997750277, 4342.131573685276, 4668.346431499593, 4744.95255047452, 3667.2665466906724, 3687.2809802088873, 3749.4750734897134, 3759.3984962405884, 3828.8468461261796, 1127.6617014895498, 1128.9548418063187, 1143.4340001699045, 1166.0, 1174.5595401724354, 1027.2809033676456, 1029.3875144289136, 1034.1158309645145, 1036.6734478639355, 1044.3107549017764, 6078.848028799315, 6139.754409823647, 6265.843353916189, 6275.560710750204, 6351.237851457855, 429.8280687724935, 429.97420154790814, 434.57194663256666, 437.964962802975, 440.42304580998353, 4312.137572485452, 4397.0, 4406.317020861771, 4413.558644135561, 4486.12520558488, 10570.10154136907, 10905.0, 10934.0, 10935.179861510418, 10938.617148399768, 10618.150547956146, 10803.405812680221, 10960.561577536968, 10960.780784384428, 10997.395143267036, 8103.10865804761, 8116.188381161836, 8193.877091843628, 8244.134365891616, 8282.792930176794, 6136.171616831849, 6142.385761423822, 6150.846228844314, 6152.569320147547, 6177.351378105414, 10153.949230253802, 10186.541605627617, 10204.13264872494, 10247.948760256151, 10305.948470257601, 10018.799624007625, 10221.23340749432, 10318.845217321896, 10336.896631033593, 10361.22290828206, 6419.133416988647, 7110.928890711027, 7267.345938865527, 7333.266673332624, 7334.96332518334, 8449.23956843887, 8535.189157030072, 8581.742547723577, 8598.39811213209, 8606.698765543177, 7643.617819108911, 7787.844243115219, 7836.843263134591, 7848.882266765889, 7986.321162701235, 7592.354649854824, 7612.80967975805, 7659.617019149132, 7667.616619169131, 7770.572618506037, 6889.035535025, 6952.513324067267, 6984.860302794017, 6987.580745155104, 6988.126484189476, 5201.505856943584, 5247.1079916415065, 5252.147815414557, 5328.333958255218, 5385.784568617368, 5417.620766546462, 5425.457454254543, 5559.416261292506, 5625.943740562542, 5643.717814109196], "value": 4444.95177223925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.72222971589014, 332.94622519725067, 338.8344096308698, 340.59979524059224, 342.05592564521913, 5342.076852333157, 5347.94104269856, 5398.2982212312445, 5403.297571315733, 5409.269748583945, 5264.710440925747, 5286.550643195333, 5293.8941221175555, 5297.867553311169, 5305.310309659749, 3838.405047217686, 3933.7836418997017, 4038.9596104039024, 4063.9187216255805, 4109.630133288004, 4082.2243773683053, 4089.5705950875176, 4113.115680128772, 4113.156802855422, 4128.731632443896, 4071.837126514936, 4076.347784354504, 4084.6732261419165, 4093.099518106012, 4099.467069281004, 3890.9027274318228, 3994.840206391741, 4074.2869997750277, 4080.0, 4110.527289361732, 3529.3117842020815, 3565.1978304881454, 3583.33708263972, 3601.3697602919647, 3616.5895300832694, 4993.976234871842, 5056.974715126437, 5060.139776238048, 5064.696118232918, 5074.5432911037815, 4464.263396539567, 4646.186917289495, 4680.555347242007, 4681.227597446417, 4689.859304220879, 5456.554013186509, 5479.53423958964, 5486.725663716838, 5494.203340515643, 5503.3395992480755, 3951.644352008333, 4013.9397909031386, 4027.7180597358197, 4043.3530635098537, 4054.6350828425584, 5491.807786727485, 5719.342275638313, 5730.426957304237, 5747.827565173052, 5765.4811067004175, 4094.7101662976065, 4110.23960567296, 4113.958860411358, 4118.629323360852, 4144.212599606065, 4166.562560901846, 4201.852935147316, 4204.5375008749015, 4206.789660516962, 4214.157168566299, 4627.8843028923875, 4628.722276663411, 4750.952490475051, 4751.40607424072, 4810.7113573185725, 5559.833205003856, 5583.720813959286, 5586.966411213938, 5596.636218645775, 5634.661615429633, 1416.164462966834, 1424.4017512644714, 1426.6019301084787, 1436.7844823276382, 1437.590286768287, 919.4713040002025, 941.355171707369, 956.3353469338742, 959.5442164971582, 972.4165500699665, 5282.947170528322, 5428.75570599324, 5448.509634132947, 5468.808591699271, 5474.39781624021, 5660.433956604306, 5665.592123347561, 5665.971670141623, 5679.204911312419, 5697.003024470701, 5267.394249661338, 5373.167159090347, 5419.972900135553, 5455.536279416215, 5478.890422191614, 3022.9395412091635, 3024.4555979923384, 3037.5595538647212, 3042.361104168105, 3049.5273232648974, 5811.651300921958, 5826.2134611827705, 5857.209276747584, 5937.921727395464, 5950.8809823803285, 5542.584306177053, 5711.6001879868845, 5756.597038207369, 5819.79630712923, 5827.242458480455, 5851.853703657443, 5853.356130825606, 5882.911756323659, 5906.586538942232, 5947.910781338283, 5378.946210537844, 5672.432756724294, 5683.829485115453, 5721.57088218377, 5729.512991395612, 5677.630953987978, 5695.316562012585, 5704.545340938034, 5713.714314284352, 5729.341125770589, 5973.253343332083, 6004.609700369462, 6010.819675409744, 6011.609245399035, 6025.969870150621, 3868.574456809805, 3943.4676318697757, 3953.3081710701085, 3966.801659916935, 3986.4219688145636, 5707.286589176353, 5717.685527295872, 5752.856178595569, 5779.537636988946, 5803.303603567599, 5446.972765136149, 5594.216809646571, 5601.271834661468, 5608.327000759935, 5637.830865074055, 5578.019802969888, 5583.860403489945, 5598.804041858515, 5628.352739434854, 5630.577706671934, 5317.548008419328, 5476.726163691879, 5522.337319521683, 5558.194061861089, 5640.294963129609, 5482.945170548243, 5616.6068375213345, 5620.494155526022, 5626.240457538343, 5631.7184140793615, 5482.616216864782, 5485.945140548703, 5507.449255074461, 5537.058700021086, 5574.358948720949], "value": 4242.1489531177795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.0, 794.3486341200218, 828.6602492977877, 831.4720152703031, 844.6030365728105, 14766.926165369172, 15213.163276019843, 15228.543143705692, 15303.846961530382, 15341.0, 13714.519991800289, 13903.513377031806, 13915.443382264722, 13945.093568918013, 14330.068545544558, 670.828938620651, 688.4526801193039, 688.9793306200797, 812.0904586862707, 823.2138307915956, 684.7124207832697, 789.743333416639, 811.3671336357651, 812.9065157506874, 821.8397412504564, 859.2138193552892, 864.7405778266526, 867.7223288547667, 868.4789126524066, 868.9131086891292, 701.2146396036471, 864.6152462154344, 864.8789169516273, 864.9870251946226, 866.2550206822159, 604.5949214026568, 624.4504835744561, 625.2590680044117, 625.8247690646626, 626.3830127324582, 13489.190648561118, 13530.323483825769, 13543.45826166952, 13545.864541354558, 13553.0, 13019.544315948897, 13412.530561430402, 13431.932840335834, 13585.0, 13614.795778063337, 11958.820617690742, 12159.209651372632, 12165.20926139807, 12299.446524906401, 12480.0, 4351.0862718829085, 4394.538573449774, 4463.709858859196, 4534.523874993111, 4564.977175114103, 57215.427845721846, 57747.422525775044, 58772.118418224185, 58921.705391473195, 59184.408155918754, 10757.193210509244, 10909.18181136418, 10998.450077496092, 11031.282966607145, 11154.442277886073, 19174.13716382766, 19211.135498902582, 19229.4231173065, 19250.903745481184, 19254.61490770177, 8056.919430805617, 8108.716194933267, 8189.50862948225, 8194.713185038496, 8239.340852731768, 4171.453294940849, 4252.0, 4254.106637606075, 4418.779061046935, 4465.24090904547, 3354.0, 3437.6218615952225, 3445.7415693823064, 3446.0, 3451.050960985699, 600.906859436788, 613.1416017575341, 617.305531277313, 624.1293395712955, 625.293418437163, 606.3814908793006, 632.2855173653742, 672.3444641474523, 715.5527795128045, 724.6304384763808, 8988.910110898807, 9428.90571094294, 9446.102620251066, 9528.380655257386, 9585.808283834283, 527.7651445106967, 621.4748537485817, 672.9125213722283, 715.1989771456002, 720.7441358317826, 4297.8495752648505, 4346.0, 4427.335899615019, 4497.460304763384, 4565.429321334833, 68295.65852170707, 68948.65525672339, 70672.0, 71199.0, 71227.2877271231, 58534.707326463096, 59724.70137649371, 60436.0, 60778.78442431126, 61725.60509171949, 47532.0, 48367.75816120897, 49380.753096234286, 57005.42994570084, 58233.41766582365, 9599.664011759554, 9854.11312981835, 9869.161121304769, 9990.850137247802, 10038.146757525692, 36166.63833361633, 36444.27111457809, 37382.813085935486, 37713.24573508569, 38096.809515953355, 46102.769486153695, 49705.76912500676, 50187.247191291426, 50234.24648630201, 50477.0, 11004.559817607525, 11174.832377514507, 12331.50673973031, 12617.242965422103, 12923.612291631267, 12150.598407551623, 12496.12527123129, 12571.0, 12824.0, 12921.418536165707, 11236.83144752813, 12219.572314968933, 12891.419886105336, 13103.60689179326, 13160.104776949056, 13156.144850584682, 13188.736225275632, 13234.139780914209, 13362.331883405985, 13570.032345310072, 12792.808107878203, 13011.21932684042, 13469.595912122651, 13535.932320338728, 13800.964927630266, 10590.89409105899, 10750.677479675622, 11173.0, 11218.439078045902, 11278.210525263154, 10939.945300273448, 10979.39613321275, 11158.49786759614, 11164.106871450427, 11210.55157793679], "value": 6846.647835147628, "unit": "score"}], "name": "dromaeo_css", "value": 7203.517350361645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 111.0, 112.0, 112.0, 113.0, 111.0, 111.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 127.0, 205.0, 125.0, 125.0, 163.0, 127.0, 166.0, 125.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 162.0, 161.0, 159.0, 162.0, 162.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 74.0, 76.0, 74.0, 77.0, 111.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 83.0, 83.0, 84.0, 123.0, 84.0, 84.0, 119.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 56.0, 60.0, 56.0, 57.0, 71.0, 53.0, 54.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 68.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 81.0, 87.0, 84.0, 86.0, 79.0, 86.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 120.0, 122.0, 121.0, 117.0, 128.0, 129.0, 165.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 166.0, 161.0, 160.0, 162.0, 166.0, 171.0, 163.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 62.0, 64.0, 63.0, 66.0, 63.0, 63.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1509.3, "alertThreshold": 2.0}]} 07:27:55 INFO - Return code: 0 07:27:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:27:55 ERROR - # TBPL SUCCESS # 07:27:55 INFO - Running post-action listener: _resource_record_post_action 07:27:55 INFO - ##### 07:27:55 INFO - ##### Finished run-tests step (success) 07:27:55 INFO - ##### 07:27:55 INFO - Running post-run listener: _resource_record_post_run 07:27:56 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 540672; Write bytes: 292933632; Read time: 120; Write time: 330972 07:27:56 INFO - TinderboxPrint: CPU usage
13.1% 07:27:56 INFO - TinderboxPrint: I/O read bytes / time
540,672 / 120 07:27:56 INFO - TinderboxPrint: I/O write bytes / time
292,933,632 / 330,972 07:27:56 INFO - TinderboxPrint: CPU idle
8,271.3 (86.9%) 07:27:56 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 07:27:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:27:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5226496; Read time: 0; Write time: 544 07:27:56 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 540672; Write bytes: 287707136; Read time: 120; Write time: 330428 07:27:56 INFO - Running post-run listener: _upload_blobber_files 07:27:56 INFO - Blob upload gear active. 07:27:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:27:56 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 07:27:56 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:27:56 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:27:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:00 INFO - (blobuploader) - INFO - Done attempting. 07:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:01 INFO - (blobuploader) - INFO - Done attempting. 07:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:02 INFO - (blobuploader) - INFO - Done attempting. 07:28:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:02 INFO - Return code: 0 07:28:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3d804282e1ce3f3a055a8db885b965973b0e21eb11bac0d2e4c1dc3ac43d96dbaf9298ad9b44911f1bb7b5d3ebf0a6278af4fdf702cd63b47a6e5542f918a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5c9f830ceba06c1a89adca7a21ffc782d1089dfb5851d31ec24bb36ef721d8f883dd53bd5aac5e26b3856f68c7d4c0f66e42f3789653b581aed3c61ba18f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54188d94ddbd10aa3ac10e8f414d64c5d007a92953553fb215e6125506da3bff60577d5df4b3bb3a7acb1223cc85e6ecedf8f6f2555aead38e0d72aa3cd6983"} 07:28:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:02 INFO - Contents: 07:28:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3d804282e1ce3f3a055a8db885b965973b0e21eb11bac0d2e4c1dc3ac43d96dbaf9298ad9b44911f1bb7b5d3ebf0a6278af4fdf702cd63b47a6e5542f918a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5c9f830ceba06c1a89adca7a21ffc782d1089dfb5851d31ec24bb36ef721d8f883dd53bd5aac5e26b3856f68c7d4c0f66e42f3789653b581aed3c61ba18f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54188d94ddbd10aa3ac10e8f414d64c5d007a92953553fb215e6125506da3bff60577d5df4b3bb3a7acb1223cc85e6ecedf8f6f2555aead38e0d72aa3cd6983"} 07:28:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:02 INFO - Copying logs to upload dir... 07:28:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.011496 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-25 07:28:02.754718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 07:28:02.757975) ========= 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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3d804282e1ce3f3a055a8db885b965973b0e21eb11bac0d2e4c1dc3ac43d96dbaf9298ad9b44911f1bb7b5d3ebf0a6278af4fdf702cd63b47a6e5542f918a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5c9f830ceba06c1a89adca7a21ffc782d1089dfb5851d31ec24bb36ef721d8f883dd53bd5aac5e26b3856f68c7d4c0f66e42f3789653b581aed3c61ba18f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54188d94ddbd10aa3ac10e8f414d64c5d007a92953553fb215e6125506da3bff60577d5df4b3bb3a7acb1223cc85e6ecedf8f6f2555aead38e0d72aa3cd6983"} build_url:https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/FwJQ7L_qT2KcdW9dzTqxKA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3d804282e1ce3f3a055a8db885b965973b0e21eb11bac0d2e4c1dc3ac43d96dbaf9298ad9b44911f1bb7b5d3ebf0a6278af4fdf702cd63b47a6e5542f918a02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5c9f830ceba06c1a89adca7a21ffc782d1089dfb5851d31ec24bb36ef721d8f883dd53bd5aac5e26b3856f68c7d4c0f66e42f3789653b581aed3c61ba18f739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54188d94ddbd10aa3ac10e8f414d64c5d007a92953553fb215e6125506da3bff60577d5df4b3bb3a7acb1223cc85e6ecedf8f6f2555aead38e0d72aa3cd6983"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 07:28:02.783543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:28:02.783916) ========= 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=52faae308a556c440401f8e5000001e8-1464185093.408036-2091746079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:28:02.867703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 07:28:02.868028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 07:28:02.868371) ========= ========= Total master_lag: 0.15 =========