builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1464612198.45 results: success (0) buildid: 20160530030222 builduid: de919baeb673425787a2c9a3cab47b2c revision: cad514ad49c199e823a92e8c8d27e16c22c3cac7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.452499) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.452965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.453557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.479686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.479997) ========= 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=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 05:43:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-30 05:43:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.606845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.607138) ========= 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=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.656157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:18.656519) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cad514ad49c199e823a92e8c8d27e16c22c3cac7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cad514ad49c199e823a92e8c8d27e16c22c3cac7 --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=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 05:43:18,855 truncating revision to first 12 chars 2016-05-30 05:43:18,855 Setting DEBUG logging. 2016-05-30 05:43:18,855 attempt 1/10 2016-05-30 05:43:18,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cad514ad49c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 05:43:19,199 unpacking tar archive at: mozilla-central-cad514ad49c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:19.401996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:19.402279) ========= script_repo_revision: cad514ad49c199e823a92e8c8d27e16c22c3cac7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:19.402685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:19.402952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 05:43:19.412481) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-30 05:43:19.412814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:19 INFO - MultiFileLogger online at 20160530 05:43:19 in /builds/slave/test 05:43:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:43:19 INFO - {'append_to_log': False, 05:43:19 INFO - 'base_work_dir': '/builds/slave/test', 05:43:19 INFO - 'blob_upload_branch': 'Firefox', 05:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:43:19 INFO - 'branch': 'Firefox', 05:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:19 INFO - 'config_files': ('talos/linux_config.py',), 05:43:19 INFO - 'default_actions': ('clobber', 05:43:19 INFO - 'read-buildbot-config', 05:43:19 INFO - 'download-and-extract', 05:43:19 INFO - 'populate-webroot', 05:43:19 INFO - 'create-virtualenv', 05:43:19 INFO - 'install', 05:43:19 INFO - 'run-tests'), 05:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:19 INFO - 'download_minidump_stackwalk': True, 05:43:19 INFO - 'download_symbols': 'ondemand', 05:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:19 INFO - 'installer_path': 'installer.exe', 05:43:19 INFO - 'log_level': 'info', 05:43:19 INFO - 'log_name': 'talos', 05:43:19 INFO - 'log_to_console': True, 05:43:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:19 INFO - 'opt_config_files': (), 05:43:19 INFO - 'pip_index': False, 05:43:19 INFO - 'sps_profile': False, 05:43:19 INFO - 'sps_profile_interval': 0, 05:43:19 INFO - 'suite': 'dromaeojs', 05:43:19 INFO - 'system_bits': '32', 05:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:19 INFO - 'title': 'talos-linux64-ix-044', 05:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:19 INFO - 'use_talos_json': True, 05:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:19 INFO - 'work_dir': 'build'} 05:43:19 INFO - ##### 05:43:19 INFO - ##### Running clobber step. 05:43:19 INFO - ##### 05:43:19 INFO - Running pre-action listener: _resource_record_pre_action 05:43:19 INFO - Running main action method: clobber 05:43:19 INFO - rmtree: /builds/slave/test/build 05:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - ##### 05:43:20 INFO - ##### Finished clobber step (success) 05:43:20 INFO - ##### 05:43:20 INFO - ##### 05:43:20 INFO - ##### Running read-buildbot-config step. 05:43:20 INFO - ##### 05:43:20 INFO - Running pre-action listener: _resource_record_pre_action 05:43:20 INFO - Running main action method: read_buildbot_config 05:43:20 INFO - Using buildbot properties: 05:43:20 INFO - { 05:43:20 INFO - "project": "", 05:43:20 INFO - "product": "firefox", 05:43:20 INFO - "script_repo_revision": "production", 05:43:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:43:20 INFO - "repository": "", 05:43:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:43:20 INFO - "buildid": "20160530030222", 05:43:20 INFO - "stage_platform": "linux64-pgo", 05:43:20 INFO - "basedir": "/builds/slave/test", 05:43:20 INFO - "nightly_build": "True", 05:43:20 INFO - "buildnumber": 310, 05:43:20 INFO - "slavename": "talos-linux64-ix-044", 05:43:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:43:20 INFO - "platform": "ubuntu64_hw", 05:43:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:20 INFO - "branch": "mozilla-central", 05:43:20 INFO - "repo_path": "mozilla-central", 05:43:20 INFO - "revision": "cad514ad49c199e823a92e8c8d27e16c22c3cac7", 05:43:20 INFO - "pgo_build": "True", 05:43:20 INFO - "builduid": "de919baeb673425787a2c9a3cab47b2c", 05:43:20 INFO - "slavebuilddir": "test" 05:43:20 INFO - } 05:43:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - ##### 05:43:20 INFO - ##### Finished read-buildbot-config step (success) 05:43:20 INFO - ##### 05:43:20 INFO - ##### 05:43:20 INFO - ##### Running download-and-extract step. 05:43:20 INFO - ##### 05:43:20 INFO - Running pre-action listener: _resource_record_pre_action 05:43:20 INFO - Running main action method: download_and_extract 05:43:20 INFO - mkdir: /builds/slave/test/build/tests 05:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:20 INFO - https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:43:27 INFO - Downloaded 1361 bytes. 05:43:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:43:27 INFO - Using the following test package requirements: 05:43:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'jsshell-linux-x86_64.zip'], 05:43:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:27 INFO - https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:29 INFO - Downloaded 24410333 bytes. 05:43:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:30 INFO - Return code: 0 05:43:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:30 INFO - https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:45 INFO - Downloaded 24410333 bytes. 05:43:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:47 INFO - Return code: 0 05:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:47 INFO - https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:48 INFO - Downloaded 10834034 bytes. 05:43:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:43:48 INFO - Return code: 0 05:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:48 INFO - https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:50 INFO - Downloaded 58748167 bytes. 05:43:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:43:50 INFO - mkdir: /builds/slave/test/properties 05:43:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:50 INFO - Contents: 05:43:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:43:51 INFO - Running post-action listener: _resource_record_post_action 05:43:51 INFO - Running post-action listener: set_extra_try_arguments 05:43:51 INFO - ##### 05:43:51 INFO - ##### Finished download-and-extract step (success) 05:43:51 INFO - ##### 05:43:51 INFO - ##### 05:43:51 INFO - ##### Running populate-webroot step. 05:43:51 INFO - ##### 05:43:51 INFO - Running pre-action listener: _resource_record_pre_action 05:43:51 INFO - Running main action method: populate_webroot 05:43:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:51 INFO - '--tppagecycles', 05:43:51 INFO - '7'], 05:43:51 INFO - 'tests': ['tsvgm']}}, 05:43:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['damp', 'tps']}, 05:43:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'tests': ['damp', 'tps']}, 05:43:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['dromaeo_dom']}, 05:43:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['a11yr', 05:43:51 INFO - 'ts_paint', 05:43:51 INFO - 'tpaint', 05:43:51 INFO - 'sessionrestore', 05:43:51 INFO - 'sessionrestore_no_auto_restore', 05:43:51 INFO - 'tabpaint']}, 05:43:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['tsvgx', 05:43:51 INFO - 'tsvgr_opacity', 05:43:51 INFO - 'tart', 05:43:51 INFO - 'tscrollx', 05:43:51 INFO - 'cart']}, 05:43:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:51 INFO - 'tsvgr_opacity', 05:43:51 INFO - 'tart', 05:43:51 INFO - 'tscrollx', 05:43:51 INFO - 'cart']}, 05:43:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'talos_options': ['--disable-e10s'], 05:43:51 INFO - 'tests': ['tp5o']}, 05:43:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'tests': ['tp5o']}, 05:43:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'talos_options': ['--disable-e10s', 05:43:51 INFO - '--xperf_path', 05:43:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:51 INFO - 'tests': ['tp5n']}, 05:43:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:51 INFO - 'talos_options': ['--xperf_path', 05:43:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:51 INFO - 'tests': ['tp5n']}}, 05:43:51 INFO - 'talos.zip': {'path': '', 05:43:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:51 INFO - Running post-action listener: _resource_record_post_action 05:43:51 INFO - ##### 05:43:51 INFO - ##### Finished populate-webroot step (success) 05:43:51 INFO - ##### 05:43:51 INFO - ##### 05:43:51 INFO - ##### Running create-virtualenv step. 05:43:51 INFO - ##### 05:43:51 INFO - Running pre-action listener: _resource_record_pre_action 05:43:51 INFO - Running main action method: create_virtualenv 05:43:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:43:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:51 INFO - Using real prefix '/usr' 05:43:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:53 INFO - Installing pip.................done. 05:43:53 INFO - Return code: 0 05:43:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:53 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:53 INFO - Using env: {'DISPLAY': ':0', 05:43:53 INFO - 'HOME': '/home/cltbld', 05:43:53 INFO - 'LANG': 'en_US.UTF-8', 05:43:53 INFO - 'LANGUAGE': 'en_US:en', 05:43:53 INFO - 'LOGNAME': 'cltbld', 05:43:53 INFO - 'MAIL': '/var/mail/cltbld', 05:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:53 INFO - 'MOZ_NO_REMOTE': '1', 05:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:53 INFO - 'NO_EM_RESTART': '1', 05:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:53 INFO - 'PWD': '/builds/slave/test', 05:43:53 INFO - 'SHELL': '/bin/bash', 05:43:53 INFO - 'SHLVL': '1', 05:43:53 INFO - 'TERM': 'linux', 05:43:53 INFO - 'TMOUT': '86400', 05:43:53 INFO - 'USER': 'cltbld', 05:43:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:53 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 INFO - Downloading/unpacking psutil>=3.1.1 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:56 INFO - Installing collected packages: psutil 05:43:56 INFO - Running setup.py install for psutil 05:43:56 INFO - building 'psutil._psutil_linux' extension 05:43:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:56 INFO - building 'psutil._psutil_posix' extension 05:43:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:56 INFO - Successfully installed psutil 05:43:56 INFO - Cleaning up... 05:43:56 INFO - Return code: 0 05:43:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:43: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 mozsystemmonitor==0.3 05:43:56 INFO - Using env: {'DISPLAY': ':0', 05:43:56 INFO - 'HOME': '/home/cltbld', 05:43:56 INFO - 'LANG': 'en_US.UTF-8', 05:43:56 INFO - 'LANGUAGE': 'en_US:en', 05:43:56 INFO - 'LOGNAME': 'cltbld', 05:43:56 INFO - 'MAIL': '/var/mail/cltbld', 05:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:56 INFO - 'MOZ_NO_REMOTE': '1', 05:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:56 INFO - 'NO_EM_RESTART': '1', 05:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:56 INFO - 'PWD': '/builds/slave/test', 05:43:56 INFO - 'SHELL': '/bin/bash', 05:43:56 INFO - 'SHLVL': '1', 05:43:56 INFO - 'TERM': 'linux', 05:43:56 INFO - 'TMOUT': '86400', 05:43:56 INFO - 'USER': 'cltbld', 05:43:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:56 INFO - '_': '/tools/buildbot/bin/python'} 05:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:59 INFO - Installing collected packages: mozsystemmonitor 05:43:59 INFO - Running setup.py install for mozsystemmonitor 05:43:59 INFO - Successfully installed mozsystemmonitor 05:43:59 INFO - Cleaning up... 05:43:59 INFO - Return code: 0 05:43:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', '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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43: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 blobuploader==1.2.4 05:43:59 INFO - Using env: {'DISPLAY': ':0', 05:43:59 INFO - 'HOME': '/home/cltbld', 05:43:59 INFO - 'LANG': 'en_US.UTF-8', 05:43:59 INFO - 'LANGUAGE': 'en_US:en', 05:43:59 INFO - 'LOGNAME': 'cltbld', 05:43:59 INFO - 'MAIL': '/var/mail/cltbld', 05:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:59 INFO - 'MOZ_NO_REMOTE': '1', 05:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:59 INFO - 'NO_EM_RESTART': '1', 05:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:59 INFO - 'PWD': '/builds/slave/test', 05:43:59 INFO - 'SHELL': '/bin/bash', 05:43:59 INFO - 'SHLVL': '1', 05:43:59 INFO - 'TERM': 'linux', 05:43:59 INFO - 'TMOUT': '86400', 05:43:59 INFO - 'USER': 'cltbld', 05:43:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:59 INFO - '_': '/tools/buildbot/bin/python'} 05:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:44:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:44:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:02 INFO - Downloading docopt-0.6.1.tar.gz 05:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:02 INFO - Running setup.py install for blobuploader 05:44:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:44:02 INFO - Running setup.py install for requests 05:44:02 INFO - Running setup.py install for docopt 05:44:02 INFO - Successfully installed blobuploader requests docopt 05:44:02 INFO - Cleaning up... 05:44:02 INFO - Return code: 0 05:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:02 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:02 INFO - Using env: {'DISPLAY': ':0', 05:44:02 INFO - 'HOME': '/home/cltbld', 05:44:02 INFO - 'LANG': 'en_US.UTF-8', 05:44:02 INFO - 'LANGUAGE': 'en_US:en', 05:44:02 INFO - 'LOGNAME': 'cltbld', 05:44:02 INFO - 'MAIL': '/var/mail/cltbld', 05:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:02 INFO - 'MOZ_NO_REMOTE': '1', 05:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:02 INFO - 'NO_EM_RESTART': '1', 05:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:02 INFO - 'PWD': '/builds/slave/test', 05:44:02 INFO - 'SHELL': '/bin/bash', 05:44:02 INFO - 'SHLVL': '1', 05:44:02 INFO - 'TERM': 'linux', 05:44:02 INFO - 'TMOUT': '86400', 05:44:02 INFO - 'USER': 'cltbld', 05:44:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:02 INFO - '_': '/tools/buildbot/bin/python'} 05:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:02 INFO - Running setup.py (path:/tmp/pip-5mNWTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:03 INFO - Running setup.py (path:/tmp/pip-FRFdNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:03 INFO - Running setup.py (path:/tmp/pip-uNPIeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:03 INFO - Running setup.py (path:/tmp/pip-XB39Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:03 INFO - Running setup.py (path:/tmp/pip-CjFRhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:03 INFO - Running setup.py (path:/tmp/pip-wWWFeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:03 INFO - Running setup.py (path:/tmp/pip-IQH3wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:03 INFO - Running setup.py (path:/tmp/pip-3pViIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:03 INFO - Running setup.py (path:/tmp/pip-Ewqi4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:03 INFO - Running setup.py (path:/tmp/pip-N36Ayr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:03 INFO - Running setup.py (path:/tmp/pip-GKCRQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:03 INFO - Running setup.py (path:/tmp/pip-gXdcR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:03 INFO - Running setup.py (path:/tmp/pip-k41D7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:03 INFO - Running setup.py (path:/tmp/pip-cAucVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:03 INFO - Running setup.py (path:/tmp/pip-2z2ugr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:04 INFO - Running setup.py (path:/tmp/pip-R_ekRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:04 INFO - Running setup.py (path:/tmp/pip-cb6Vp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:04 INFO - Running setup.py install for manifestparser 05:44:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Running setup.py install for mozcrash 05:44:04 INFO - Running setup.py install for mozdebug 05:44:04 INFO - Running setup.py install for mozdevice 05:44:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Running setup.py install for mozfile 05:44:04 INFO - Running setup.py install for mozhttpd 05:44:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Running setup.py install for mozinfo 05:44:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Running setup.py install for mozInstall 05:44:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:44:04 INFO - Running setup.py install for mozleak 05:44:05 INFO - Running setup.py install for mozlog 05:44:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Running setup.py install for moznetwork 05:44:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Running setup.py install for mozprocess 05:44:05 INFO - Running setup.py install for mozprofile 05:44:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Running setup.py install for mozrunner 05:44:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Running setup.py install for mozscreenshot 05:44:05 INFO - Running setup.py install for moztest 05:44:05 INFO - Running setup.py install for mozversion 05:44:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:44:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:05 INFO - Cleaning up... 05:44:05 INFO - Return code: 0 05:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:05 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:05 INFO - Using env: {'DISPLAY': ':0', 05:44:05 INFO - 'HOME': '/home/cltbld', 05:44:05 INFO - 'LANG': 'en_US.UTF-8', 05:44:05 INFO - 'LANGUAGE': 'en_US:en', 05:44:05 INFO - 'LOGNAME': 'cltbld', 05:44:05 INFO - 'MAIL': '/var/mail/cltbld', 05:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:05 INFO - 'MOZ_NO_REMOTE': '1', 05:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:05 INFO - 'NO_EM_RESTART': '1', 05:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:05 INFO - 'PWD': '/builds/slave/test', 05:44:05 INFO - 'SHELL': '/bin/bash', 05:44:05 INFO - 'SHLVL': '1', 05:44:05 INFO - 'TERM': 'linux', 05:44:05 INFO - 'TMOUT': '86400', 05:44:05 INFO - 'USER': 'cltbld', 05:44:05 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:05 INFO - '_': '/tools/buildbot/bin/python'} 05:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:06 INFO - Running setup.py (path:/tmp/pip-_m6BbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:06 INFO - Running setup.py (path:/tmp/pip-Zs5GXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:06 INFO - Running setup.py (path:/tmp/pip-H677ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:06 INFO - Running setup.py (path:/tmp/pip-SJzYvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:06 INFO - Running setup.py (path:/tmp/pip-V1oFWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:06 INFO - Running setup.py (path:/tmp/pip-di6ETW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:06 INFO - Running setup.py (path:/tmp/pip-0Zbo0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:06 INFO - Running setup.py (path:/tmp/pip-CoNyIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:06 INFO - Running setup.py (path:/tmp/pip-S0elRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:06 INFO - Running setup.py (path:/tmp/pip-qze0A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:06 INFO - Running setup.py (path:/tmp/pip-qHubdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:06 INFO - Running setup.py (path:/tmp/pip-ywQcr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:07 INFO - Running setup.py (path:/tmp/pip-EasxJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:07 INFO - Running setup.py (path:/tmp/pip-_rgOTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:07 INFO - Running setup.py (path:/tmp/pip-pLrJ7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:07 INFO - Running setup.py (path:/tmp/pip-WaoMaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:07 INFO - Running setup.py (path:/tmp/pip-TzGCSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:09 INFO - Downloading blessings-1.6.tar.gz 05:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:09 INFO - Installing collected packages: blessings 05:44:09 INFO - Running setup.py install for blessings 05:44:09 INFO - Successfully installed blessings 05:44:09 INFO - Cleaning up... 05:44:09 INFO - Return code: 0 05:44:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:09 INFO - Reading from file tmpfile_stdout 05:44:09 INFO - Current package versions: 05:44:09 INFO - argparse == 1.2.1 05:44:09 INFO - blessings == 1.6 05:44:09 INFO - blobuploader == 1.2.4 05:44:09 INFO - docopt == 0.6.1 05:44:09 INFO - manifestparser == 1.1 05:44:09 INFO - mozInstall == 1.12 05:44:09 INFO - mozcrash == 0.17 05:44:09 INFO - mozdebug == 0.1 05:44:09 INFO - mozdevice == 0.48 05:44:09 INFO - mozfile == 1.2 05:44:09 INFO - mozhttpd == 0.7 05:44:09 INFO - mozinfo == 0.9 05:44:09 INFO - mozleak == 0.1 05:44:09 INFO - mozlog == 3.2 05:44:09 INFO - moznetwork == 0.27 05:44:09 INFO - mozprocess == 0.22 05:44:09 INFO - mozprofile == 0.28 05:44:09 INFO - mozrunner == 6.11 05:44:09 INFO - mozscreenshot == 0.1 05:44:09 INFO - mozsystemmonitor == 0.3 05:44:09 INFO - moztest == 0.7 05:44:09 INFO - mozversion == 1.4 05:44:09 INFO - psutil == 3.1.1 05:44:09 INFO - requests == 1.2.3 05:44:09 INFO - wsgiref == 0.1.2 05:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:09 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:09 INFO - Using env: {'DISPLAY': ':0', 05:44:09 INFO - 'HOME': '/home/cltbld', 05:44:09 INFO - 'LANG': 'en_US.UTF-8', 05:44:09 INFO - 'LANGUAGE': 'en_US:en', 05:44:09 INFO - 'LOGNAME': 'cltbld', 05:44:09 INFO - 'MAIL': '/var/mail/cltbld', 05:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:09 INFO - 'MOZ_NO_REMOTE': '1', 05:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:09 INFO - 'NO_EM_RESTART': '1', 05:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:09 INFO - 'PWD': '/builds/slave/test', 05:44:09 INFO - 'SHELL': '/bin/bash', 05:44:09 INFO - 'SHLVL': '1', 05:44:09 INFO - 'TERM': 'linux', 05:44:09 INFO - 'TMOUT': '86400', 05:44:09 INFO - 'USER': 'cltbld', 05:44:09 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:09 INFO - '_': '/tools/buildbot/bin/python'} 05:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:09 INFO - Cleaning up... 05:44:09 INFO - Return code: 0 05:44:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:09 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:09 INFO - Using env: {'DISPLAY': ':0', 05:44:09 INFO - 'HOME': '/home/cltbld', 05:44:09 INFO - 'LANG': 'en_US.UTF-8', 05:44:09 INFO - 'LANGUAGE': 'en_US:en', 05:44:09 INFO - 'LOGNAME': 'cltbld', 05:44:09 INFO - 'MAIL': '/var/mail/cltbld', 05:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:09 INFO - 'MOZ_NO_REMOTE': '1', 05:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:09 INFO - 'NO_EM_RESTART': '1', 05:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:09 INFO - 'PWD': '/builds/slave/test', 05:44:09 INFO - 'SHELL': '/bin/bash', 05:44:09 INFO - 'SHLVL': '1', 05:44:10 INFO - 'TERM': 'linux', 05:44:10 INFO - 'TMOUT': '86400', 05:44:10 INFO - 'USER': 'cltbld', 05:44:10 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:10 INFO - '_': '/tools/buildbot/bin/python'} 05:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:10 INFO - Downloading/unpacking jsonschema 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:12 INFO - warning: no files found matching '*.txt' 05:44:12 INFO - no previously-included directories found matching 'build' 05:44:12 INFO - no previously-included directories found matching 'dist' 05:44:12 INFO - no previously-included directories found matching '.git*' 05:44:12 INFO - Installing collected packages: jsonschema, functools32 05:44:12 INFO - Running setup.py install for functools32 05:44:12 INFO - warning: no files found matching '*.txt' 05:44:12 INFO - no previously-included directories found matching 'build' 05:44:12 INFO - no previously-included directories found matching 'dist' 05:44:12 INFO - no previously-included directories found matching '.git*' 05:44:12 INFO - Successfully installed jsonschema functools32 05:44:12 INFO - Cleaning up... 05:44:12 INFO - Return code: 0 05:44:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:12 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 0x7f0f9ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c53770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:44:12 INFO - Using env: {'DISPLAY': ':0', 05:44:12 INFO - 'HOME': '/home/cltbld', 05:44:12 INFO - 'LANG': 'en_US.UTF-8', 05:44:12 INFO - 'LANGUAGE': 'en_US:en', 05:44:12 INFO - 'LOGNAME': 'cltbld', 05:44:12 INFO - 'MAIL': '/var/mail/cltbld', 05:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:12 INFO - 'MOZ_NO_REMOTE': '1', 05:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:12 INFO - 'NO_EM_RESTART': '1', 05:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:12 INFO - 'PWD': '/builds/slave/test', 05:44:12 INFO - 'SHELL': '/bin/bash', 05:44:12 INFO - 'SHLVL': '1', 05:44:12 INFO - 'TERM': 'linux', 05:44:12 INFO - 'TMOUT': '86400', 05:44:12 INFO - 'USER': 'cltbld', 05:44:12 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:12 INFO - '_': '/tools/buildbot/bin/python'} 05:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:12 INFO - Downloading/unpacking flake8 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:15 INFO - no previously-included directories found matching 'docs/_build' 05:44:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:15 INFO - Running setup.py install for pep8 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:15 INFO - no previously-included directories found matching 'docs/_build' 05:44:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:44:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:15 INFO - Cleaning up... 05:44:15 INFO - Return code: 0 05:44:15 INFO - Running post-action listener: _resource_record_post_action 05:44:15 INFO - Running post-action listener: _start_resource_monitoring 05:44:15 INFO - Starting resource monitoring. 05:44:15 INFO - ##### 05:44:15 INFO - ##### Finished create-virtualenv step (success) 05:44:15 INFO - ##### 05:44:15 INFO - ##### 05:44:15 INFO - ##### Running install step. 05:44:15 INFO - ##### 05:44:15 INFO - Running pre-action listener: _resource_record_pre_action 05:44:15 INFO - Running main action method: install 05:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:15 INFO - Reading from file tmpfile_stdout 05:44:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:15 INFO - Reading from file tmpfile_stdout 05:44:15 INFO - Output received: 05:44:15 INFO - Usage: mozinstall [options] installer 05:44:15 INFO - Options: 05:44:15 INFO - -h, --help show this help message and exit 05:44:15 INFO - -d DEST, --destination=DEST 05:44:15 INFO - Directory to install application into. [default: 05:44:15 INFO - "/builds/slave/test"] 05:44:15 INFO - --app=APP Application being installed. [default: firefox] 05:44:15 INFO - mkdir: /builds/slave/test/build/application 05:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:44:32 INFO - Reading from file tmpfile_stdout 05:44:32 INFO - Output received: 05:44:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:32 INFO - Running post-action listener: _resource_record_post_action 05:44:32 INFO - ##### 05:44:32 INFO - ##### Finished install step (success) 05:44:32 INFO - ##### 05:44:32 INFO - ##### 05:44:32 INFO - ##### Running run-tests step. 05:44:32 INFO - ##### 05:44:32 INFO - Running pre-action listener: _resource_record_pre_action 05:44:32 INFO - Running main action method: run_tests 05:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:32 INFO - Python 2.7.3 05:44:32 INFO - Return code: 0 05:44:32 INFO - grabbing minidump binary from tooltool 05:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:32 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 0x2ce29c0>, '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 0x2ce38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:44:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:44:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:32 INFO - Return code: 0 05:44:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:44:33 INFO - Return code: 0 05:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:44:33 INFO - Using env: {'DISPLAY': ':0', 05:44:33 INFO - 'HOME': '/home/cltbld', 05:44:33 INFO - 'LANG': 'en_US.UTF-8', 05:44:33 INFO - 'LANGUAGE': 'en_US:en', 05:44:33 INFO - 'LOGNAME': 'cltbld', 05:44:33 INFO - 'MAIL': '/var/mail/cltbld', 05:44:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:33 INFO - 'MOZ_NO_REMOTE': '1', 05:44:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:33 INFO - 'NO_EM_RESTART': '1', 05:44:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:33 INFO - 'PWD': '/builds/slave/test', 05:44:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:33 INFO - 'SHELL': '/bin/bash', 05:44:33 INFO - 'SHLVL': '1', 05:44:33 INFO - 'TERM': 'linux', 05:44:33 INFO - 'TMOUT': '86400', 05:44:33 INFO - 'USER': 'cltbld', 05:44:33 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315', 05:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:33 INFO - '_': '/tools/buildbot/bin/python'} 05:44:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:44:33 INFO - mozversion application_buildid: 20160530030222 05:44:33 INFO - mozversion application_changeset: cad514ad49c199e823a92e8c8d27e16c22c3cac7 05:44:33 INFO - mozversion application_display_name: Nightly 05:44:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:33 INFO - mozversion application_name: Firefox 05:44:33 INFO - mozversion application_remotingname: firefox 05:44:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:33 INFO - mozversion application_vendor: Mozilla 05:44:33 INFO - mozversion application_version: 49.0a1 05:44:33 INFO - mozversion platform_buildid: 20160530030222 05:44:33 INFO - mozversion platform_changeset: cad514ad49c199e823a92e8c8d27e16c22c3cac7 05:44:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:33 INFO - mozversion platform_version: 49.0a1 05:44:33 INFO - using testdate: 1464612273 05:44:33 INFO - actual date: 1464612273 05:44:33 INFO - starting webserver on 'localhost:54290' 05:44:33 INFO - SUITE-START | Running 2 tests 05:44:33 INFO - TEST-START | dromaeo_css 05:44:33 INFO - operating with platform_type : linux_ 05:44:33 INFO - Initialising browser for dromaeo_css test... 05:44:33 INFO - TEST-INFO | started process 22690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThSKlw/profile http://localhost:54290/getInfo.html) 05:44:38 INFO - PROCESS | 22690 | __metrics Screen width/height:1600/1200 05:44:38 INFO - PROCESS | 22690 | colorDepth:24 05:44:38 INFO - PROCESS | 22690 | Browser inner width/height: 1024/697 05:44:38 INFO - PROCESS | 22690 | __metrics 05:44:39 ERROR - PROCESS | 22690 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:44:40 INFO - TEST-INFO | 22690: exit 0 05:44:40 INFO - Browser initialized. 05:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:40 INFO - TEST-INFO | started process 22772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThSKlw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:51 INFO - PROCESS | 22772 | RSS: Main: 155664384 05:44:51 INFO - PROCESS | 22772 | 05:45:43 INFO - PROCESS | 22772 | 1464612343043 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:50 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54290/tests/dromaeo/cssquery-ext.html) 05:47:51 INFO - PROCESS | 22772 | RSS: Main: 243785728 05:47:51 INFO - PROCESS | 22772 | 05:50:54 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-ext.html (next: http://localhost:54290/tests/dromaeo/cssquery-jquery.html) 05:50:55 INFO - PROCESS | 22772 | RSS: Main: 239644672 05:50:55 INFO - PROCESS | 22772 | 05:53:57 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54290/tests/dromaeo/cssquery-mootools.html) 05:53:57 INFO - PROCESS | 22772 | RSS: Main: 248270848 05:53:57 INFO - PROCESS | 22772 | 05:56:59 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54290/tests/dromaeo/cssquery-prototype.html) 05:57:00 INFO - PROCESS | 22772 | RSS: Main: 233521152 05:57:00 INFO - PROCESS | 22772 | 06:00:03 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54290/tests/dromaeo/cssquery-yui.html) 06:00:03 INFO - PROCESS | 22772 | RSS: Main: 228646912 06:00:03 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | Cycle 1(1): loaded http://localhost:54290/tests/dromaeo/cssquery-yui.html (next: http://localhost:54290/tests/dromaeo/cssquery-dojo.html) 06:03:06 INFO - PROCESS | 22772 | RSS: Main: 279687168 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | __start_tp_report 06:03:06 INFO - PROCESS | 22772 | _x_x_mozilla_page_load 06:03:06 INFO - PROCESS | 22772 | _x_x_mozilla_page_load_details 06:03:06 INFO - PROCESS | 22772 | |i|pagename|runs| 06:03:06 INFO - PROCESS | 22772 | |0;dojo.html;3133.248020475087;3137.419577378185;3144.779865409421;3169.176014236301;3179.538966849807;5203.973980130104;5272.604554658406;5287.814926477574;5335.039692855289;5340.332458442699;5322.148456247001;5361.678299302035;5378.596605254602;5414.810481633143;5434.646747961389;4845.466998630157;4866.6106711463;4999.425066117388;5039.344885164924;5076.36545431821;4946.629002824785;4979.626528010395;4991.251312303148;5006.949930500703;5012.82455114071;4778.25936979767;4818.638602104857;4843.66094373394;4901.632377571678;4930.654854160211;4921.434035085975;4924.384451943507;4930.260460930889;4942.308076869242;4981.37732783402;4868.683535570212;4899.779509922062;4929.827456039057;4930.03864246472;4950.455449900508;5144.511271429208;5166.689998600096;5248.422673505911;5324.7071411072375;5388.299521062276;5625.746841392147;5653.604247702662;5653.660780353151;5740.138979153118;5740.54075673945;5751.769929202868;5775.537956963475;5791.507721843648;5797.971010144965;5803.187553742479;5189.455107213726;5345.465453454663;5380.408155102936;5382.354117505885;5463.2078348639225;5960.493358064527;5977.671228082497;5979.133025711248;5989.401059894063;5991.940080599138;5541.085720856095;5680.176374425685;5693.914591281051;5727.198192253005;5740.253767010262;5639.182318563868;5689.118186681071;5698.145278208219;5736.598438109292;5739.62692424991;5614.6631202128;5648.78551111513;5698.572607054488;5706.9714651426475;5710.65736055838;5425.186222066643;5653.349864765522;5660.433956604306;5661.377248502661;5759.8560035999435;4415.933760993587;4425.402570652921;4441.156180325728;4466.173757854807;4470.195364834296;3937.6062393760967;3944.881653550398;3957.445957565943;3969.3450580654444;3983.083890705096;5406.648567843077;5417.5395091416885;5575.024370735106;5579.302587176603;5589.8602534936135;5715.942840571541;5743.8564035899435;5748.223989761413;5767.106098554731;5786.450287222707;5513.641613295123;5514.36584792754;5520.530754885799;5524.8342549723575;5525.751341189656;4843.370361852936;4888.315635810989;4905.607551395879;4946.727929963887;4948.703077815343;5940.4653581177035;6036.63780173191;6036.788712395045;6040.36576159497;6088.208532890696;5829.15477255804;5836.649801011953;5841.474267315962;5842.824715258549;5844.15259787337;5855.23881895368;6048.90926636092;6064.666443345658;6074.088886667036;6096.634201947897;5773.884522309446;5783.045797443543;5783.624064435799;5788.247527821356;5829.708514574169;5833.67914764692;5837.6497410155525;5883.823485295448;5898.262717160355;5900.203472531153;5450.972745136249;5623.606347555632;5638.182463542681;5650.463205995424;5738.713064346849;5638.097904335286;5647.802326918538;5650.519705824887;5651.717414129359;5712.6286791358425;5633.4084921082695;5633.8309850704545;5634.690092044977;5635.182898479616;5642.633228840113;5550.333959924835;5692.231548740867;5748.683822389641;5761.049426844524;5853.0635098384055;5631.070873305859;5649.293838270216;5658.717064146694;5665.263515743092;5714.257146570919 06:03:06 INFO - PROCESS | 22772 | |1;ext.html;584.868404608963;629.6033498895695;634.6128861394549;650.9218893732752;653.6404977262505;33057.83471082644;43698.56301436984;44452;44465.33302000473;48600.270995935;44622;45280.77359613206;45388.773056134756;45437.318440223426;45505.31742023864;8766.649334026632;8918.464892106495;8929.73210803677;8942.239909607692;8946.64213431462;8655.95672021639;8773.56132193391;8781.736547903573;8786.033536311;8786.516741579211;8802.86795698065;8853.291736661084;8870.201681848632;8872.290216782641;8876.556172191396;8802.515861627608;8842.557872106368;8844.690435834715;8848.424852384607;8848.911510884873;8754.518501482416;8877.422967507091;8886.066962968924;8886.644534218623;8886.911130888673;42277;42752.3587146193;42869.57130428687;42876.35685464721;42903;3415.8292085395633;3555.3422616815974;3564.233689756689;3669.7798132112157;3936.291467535871;30331.696683033108;32419.189520261945;32820.179495512566;34244.657553424644;34276.48585271223;4316.330968699856;4429.247028005247;4473.3960915276675;4495.865124046284;4520.570545798144;345460;356333.9999999974;356818;357237;357380;63840.36159638344;64174;64852.67573662196;64873.05380838583;65002.67498662571;58392.708036459546;68066;69398.65300673565;69654.30345696479;69654.65172674104;16299.918500407422;16918.06950617703;16942.915285423493;17435.73846392305;17443.73834392485;12583.874161258453;12723.936380318039;12751.043671724658;12751.36243187837;12772.61682149537;18027.819721802876;19657.03429657023;20433.897830510752;20510.282140125324;20631.277905273244;7364.116306043309;7532.585707786125;7675.42873137494;7723.459357844897;7730.806729831799;972.9075737804898;1044.8484969679505;1122.6014764758393;1161.3148242536943;1212.2847519963263;32179;32564.34871302608;32613.673863261065;32707.83646081802;33350.833245833615;1096.7313008313015;1126.7690123524658;1135.3868910788083;1167.9824802627968;1250.1623911978995;16947.237374317938;16962.660746784994;17260.568485787957;17366.700765987076;17527.824721752873;519291;624741;637177;637660;637667;59714.402855971755;60042.09936850951;60204.698976504835;60224;60226;1272.3765354975994;1353.1204716933876;1385.1273697570668;1393.7212557488542;1397.475946520055;30791;32300.515492268103;32359.838200808845;32612.83693581517;32953.17617059593;51071;51181.7440912793;51746.74126629343;51824.48175518347;51860.740696297784;409891;410184;412154;413357;416638;25447.6182857261;28683;29251.561226582045;30236.395272094876;30299;47394.289085663055;47672.523274766805;48243.5175648239;48413.27380089231;48736.75631621961;40141;40599.59400405958;40978;41350;41750.37374439446;40487;40787.79606101951;41059.58940410558;41445;41840.16319673529;36269.45595816012;39995.20009599734;40245.79877100596;40864.387034195104;42137.57862421337;34427.483587746705;37099.44350834793;37121.81439092787;37260;37406.812965934994;28048.57927131054;28577.571336429555;28591.42817143687;28645.283867902635;28792.856035719687 06:03:06 INFO - PROCESS | 22772 | |2;jquery.html;386.8994061543998;389.35950361655097;398.7408184679958;406.7417190084296;424.93201087825935;14076.788848167285;16123.27445264963;17689.823101768994;19453.12460939256;19522.121504532293;18238.726419103692;18471.445856624323;18495.35266265681;18962.241510339605;19392.321268755597;5468.425815289397;5600.075987462084;5648.293963254593;5648.915266271009;5685.772569097231;4079.6940229482757;5444.564434845222;5525.475079867406;5845.766169353242;6240.188775459206;6204.689765511729;6251.374862513735;6289.37106289372;6310.053491976194;6318.71565779541;6183.87632247357;6213.409726076015;6292.685365731695;6292.842678933041;6373.808785736435;5489.890202195974;5568.7215639217875;5608.411116832755;5622.606417550773;5624.493795558419;23538.940747666395;23669.171578994825;23753.168639097723;24020.399490012715;24230.636540451906;2367.6685264063044;2401.6877805885297;2431.489387228684;2493.488834788864;2524.0534799450206;14924;15544.689106217926;15623.609409764847;15733.449329273535;16117.838821611751;1947.2795065825594;2059.721937538428;2070.637638413287;2108.7574928883223;2238.8432809703327;88419.55790221073;94266;94422;95370;98176.50911745467;16863.831361686473;18101.18988101206;18229.817701823078;18369.63260734778;18443.446696599123;32430.35139297248;32558.34883302368;32755.34489310248;32819.83590082034;32852.178695532326;9795.118439340351;10128.139108175741;10148.137408320228;10219.9489002556;10224.59101635941;8398.580070996426;8449.112843151504;8489.915100849035;8583.399162058597;8606.182412670787;8897.199252067345;9052.23056040244;9072.8639070414;9136.360454768235;9302;3367.830380366126;3465.2722928185362;3583.8387272572795;3584.8632446609217;3596.2088340565033;901.1799262670938;976.6581696406201;991.5686676295834;1013.2147585621055;1083.539495714334;18766.49868010556;19194.52013699641;19344;19377.4186774397;19707.113179906937;983.2085171437062;993.2500961773815;993.8360170571775;1061.9893801062044;1090.8654998801157;10224.488775561193;10532.10477109439;10979.505922233519;11062.446877656084;11086;483386;486261;493234;497551;498821;67718.66140669266;76573;76643;96741.51629241949;99004;1036.1917704190744;1036.4558606731525;1069.7967386196597;1070.5182667799522;1075.2097208551709;17038.14809259557;17051;17131.657366852844;17355.392561260294;17788.733169002215;40478.1904361917;41073.38389924213;42103;42182;42237;55164.903236119084;55575;56313.46589403569;60518.394816051274;60596.697016514634;11041.558337666404;11182.720431989266;11544.82682759776;11714.824277636013;12044;12919.483220671067;13183.406746696613;13185.472581097032;13214.339283035617;13261.734765304447;10947.507362168562;11367.943160284476;11412.144089193178;11540.076793856304;11572.479238434122;11089.518461715117;11297.661070167907;11478.483468244116;11539.596114135966;11652.30086194831;11447.427628618369;11570.76858462843;11595.897804965787;11670.70823229426;11935.582254621047;11416.257943233662;11489.655310340702;11533.94233028863;11617.535298587962;11631.59289424866;11528.308301501937;11540.596079137189;11703.590374337198;11775.133572005376;11863.822042669539 06:03:06 INFO - PROCESS | 22772 | |3;mootools.html;1323.4671250965453;1501.7146742118994;1517.5902506323293;1681.9074950877705;1807.5842556212071;8383.706570270035;8715.389922705404;8728.083551227117;8940.105989401056;8948.015718270985;8627.741167764978;8837.779055523615;8845.513496757692;8851.91148088519;8854.86717699235;1951.112243929016;2325.4418939454577;2384.5350156719446;2385.916492922748;2427.2718184544656;2428.9878550607223;2432.8783560821976;2436.7806897379232;2439.5852705040184;2440.707115146176;2319.617263151578;2361.7756313150308;2362.5156842847173;2366.0417530900013;2367.183321753992;1980.1188471130354;2299.3217000984664;2349.553584818879;2351.7648235176516;2387.5344307859973;2305.919292824743;2323.453988312745;2331.1141766128762;2340.4265954841003;2343.379004563792;8707.216350528419;8808.207261346446;8809.691660791841;8814.735557933273;8816.338774591932;5278.762455689503;5431.945680543184;5433.864153396157;5437.891242175174;5440.809571664972;3314.254292784128;3454;3481.686648201674;3483.0073429072845;3491.8428670709627;1182.8639706433785;1192.2825729340111;1247.5134697467995;1267.3789842976967;1271.1927925767204;12425.19236249641;12426.751464970741;12534.122611417204;12535.24788512692;12535.373231338397;4715.339852420664;4762.666613337033;4837.879053023703;4839;4864.246041863516;9674.613015479443;9682.370645907993;9749.36629119105;9751.90248097524;9754.707358779247;4674.158651442773;5345.091334473149;5357.8392648220615;5360.678359298455;5366.141417373202;4809.927851082237;4899.706017638953;4938.111139994836;4977.203647416396;4984.27727979441;3813.218290250492;3924.862629807943;3944.723869329119;3987.8404863805704;4024.6981476389387;1138.2373809547623;1138.6584024792528;1139.3107170162098;1160.802663547199;1176.4470698771563;1002.5638847101388;1004.3371374892536;1024.8872624011353;1026.5483187397522;1037.1547189040907;6105.419985101408;6139.815805525842;6264.718087686065;6291.433770960635;6292.748290068346;975.7511834482161;979.8775153105862;1010.5351538292468;1041.6250149946013;1052.752603138262;4206.537280899099;4313.374560688682;4443.089166720814;4457.598816106566;4510.954890451054;10295.176385889112;10543.736406589896;10560.630377936735;10583.682489525327;10591.57633694659;10386.948065259625;10738.248322617343;10777.946110269399;11025.117990560735;11085.889141108486;8028.397870159762;8189.918100818915;8191;8200.507969521848;8201.13888041759;6166.105914642262;6380.202474690664;6452.451541619015;6468.676566171766;6525.347465253437;9875;10134.037266459674;10310.896891031294;10364.481775911023;10389.584416623251;10291.33106348085;10309.536070876979;10379.688609341732;10388.220883433622;10392.16862650971;6930.7227710891;7058.470614704021;7862.646180921986;7892;8059.556724379981;8719.476831390137;8770.342224333073;8843.07147749477;8844.248238899765;8848.026717061246;7623.428242881695;7666.846663066596;7777.533347999138;7840.3335716464735;7948.562829044458;7662.233776622516;7662.272084151997;7763.68945242184;7883.802904927423;7884.487508311941;7131.928680713127;7157.284271572801;7160.498765086394;7216.170140433917;7232.63836808147;5043.2435134730085;5084.542391184811;5192;5221.242919776687;5246.396664383492;5169.276301317744;5225.320708307896;5226;5264.9736751315995;5382 06:03:06 INFO - PROCESS | 22772 | |4;prototype.html;303.29332654914055;308.56954548404974;310.2244389027431;318.47928636679023;318.80712169137684;5290.285811415458;5359.142537194045;5375.569954403653;5382.3852844146695;5434.429384914586;5250.18622113572;5316.893662126765;5336.466353364662;5339.492748188916;5345.385280692722;4120.567340429249;4137.924139723664;4199.874003779892;4210.705250632457;4232.068944832132;4098.918021639565;4174.332106862903;4180.79096045198;4183.874483765492;4194.273722080641;4095.685937445334;4121.9381709274385;4147.854825081123;4148.481439820022;4151.086760912594;3916.353801622729;4028.4158796974566;4134.2144992451485;4158.627652874544;4163.666906647461;3398.235397035647;3456.412409890325;3560.8041557714573;3561.679448849616;3600.513930619385;5048.1418158913075;5054.671446355975;5056.924146137811;5071.2139618359215;5105.310783044279;4651.279051746985;4662.230731929228;4663.860084197479;4666.95333046672;4670.883227919295;5234.345706786652;5247.02929957959;5464.797744496204;5481.534069604048;5526.253955715967;3913.4521167036637;3929.2534418460687;3942.6989093599045;3958.920821583581;3975.6819454443576;5517.5585953123655;5596.552275817966;5817;5839.8540036499;5841.474267315962;3995.20095980805;4010.2380547695843;4027.496562929634;4027.6708686133506;4055.736377135536;4077.1845630873945;4081.7959102045374;4086.1010577672864;4097.651699605567;4117.053077792065;4444.511103778582;4626.421697287839;4665.370175026396;4666.906661866744;4722.504137065627;5505.862353441116;5520.3651580068;5531.3362396511875;5550.500454958992;5579.9163012554845;1363.9795403068963;1378.97266536431;1381.5026590427437;1396.7136736968896;1401.1943132698739;861.7285555050139;906.9818603628022;909.5770466732869;911.2072496927583;920.9593159729462;4854.5873600744335;4877.878053048631;4878.780454879468;4886.706797592155;4891.779869905863;5067.569256613156;5078.390593128848;5090.389153301628;5093.134167191586;5101.20931255656;4700.647451441156;4843.903121937541;4871.952530206023;4884.8290309838985;4914.238293064581;2687.314734742667;2697;2698.3389069678055;2704.580789977557;2709.7425744554234;5273.233466788669;5376.7042812644895;5379.731013449312;5384.434634363335;5394.083005889008;4738.502457242009;5138.511841375063;5159.7678104485385;5202.606800871566;5262.710550919736;5246.895062098737;5255.947440525699;5274.446183150791;5277.258504693442;5335.785648955718;5043.52086551777;5050.646454748133;5050.797968081236;5062.848114556422;5114.4629813869005;4845;4952.2306512912055;5013.573846223112;5050.873728156826;5067.214581739836;5629.296337957755;5861.208736820645;5925.911111333247;5949.25634295713;6004.699765011819;4033.3546632538655;4038.818253178673;4068.9796551017057;4073.735207211522;4083.8570650027104;5559.388467268678;5655.321361436654;5771.509421699203;5772.624779389326;5781.739821707949;5506.485716428015;5531.593756715842;5554.888902222014;5561;5625.240592520121;5537.5569954402745;5540.473655002768;5555.861103472445;5556.833295001156;5571.774209673866;5203.505666961632;5427.158790387496;5482.780688772405;5484.698341591251;5497.230387745799;5573.1918871762555;5575.832725018256;5591.608587398843;5619.690916999604;5627.705627705569;5288.365396152486;5363.651362661414;5426.457354264542;5499.697516636464;5505.587080969023 06:03:06 INFO - PROCESS | 22772 | |5;yui.html;773.3697036914914;796.9760907172783;799.9400044996625;806.1132753970637;853.2363534636501;14572.271386430675;15434.845651543481;15616.76574851378;15635.687286254268;15642.217889105556;14455.277236138178;14759.631009224748;14764.852351476482;15364.923175384136;15422.69154616907;676.3777324861139;794.3526026288586;799.348530947279;800.7037396163413;802.2378740196837;798.2017982017982;807.3258828877894;807.4912804932884;808.3048578222753;808.5270116981573;833.8165603567205;839.3369238301734;839.7984483723924;839.8698201778734;840.794005468661;711.6086152616066;808.2644793238184;819.7090033038245;837.0792128658458;838.1325328285226;612.4610342898221;612.9448349648553;614.7602435050334;615.0374663651415;615.3047056825803;13090.934545327307;13100.60698179056;13139.671508212276;13144.539941102015;13148.934255328662;12922.353882305848;13159.53941612039;13394.598162055154;13409.46362145513;13743.587692369245;12403.813942790865;12529.185602935871;12700.80948785769;12733.426995785212;12927.612171634866;4342.652587792969;4415.271480205794;4452.154090722753;4470.396496472967;4592.494825569184;58070.70964645192;58342.416575834126;58430;61545.69227153881;61732.38267617356;10457.215708821868;10569.894301057046;10577.84133238002;10620;10793.29843560166;18370;18420.35528756487;18449.81550184481;18464;18479.260829566934;7937.603119843985;7972.760817175494;7994.560299183485;8003.639836207385;8112.391570632226;4491.124230774967;4557.453105627346;4569.725816451024;4654.697444666086;4792.185328494164;3332.3668502984356;3369.2419205678525;3405.6934875861293;3414.231797845465;3418.504316874089;550.8953298873201;607.8541150124026;612.8774245150987;621.1056079245961;628.6165439082156;600.7566935391174;603.7584966013542;604.8760004199129;665.5108495255982;682.3654001778294;9147.2682185425;9626.229901607854;9666;9804.558794854105;9823.214142868554;624.4224092714221;673.8820706376365;677.4546490075536;707.7912015955305;709.5848928376957;4241.194173107161;4796.424429068534;5019.924701129486;5079.466656001141;5102.081625307406;68063;68629;70364.2963570368;70574;71344;63413.68293158505;64699.35300646933;64809.67595161994;65366;65578.34421655722;58237.70881145567;58693;59171.70414147988;59343.40656593465;59344.70327648334;9898.505074746377;9932.503374831085;10053.849192261976;10097.44464054484;10162.745931351776;38094.61905380911;38246.42630360602;38311.04222394351;38782;39304.80347598244;45426.77286613678;52098.73950630223;52560.47439525556;52638;52803.47196527985;12670.809937850756;12706.618801435972;12795.104342696295;12937.54718584845;13005.674858128623;13823.377947992565;14015.229162396166;14191.219482928538;14303.07030043044;14785.556433307018;13283;13620.31898405056;13921.164730116225;13935.442582296595;14104.929475352557;12818.294993775431;12977.545785897448;13140.408681609159;13206.735865282833;13469.49686157261;13066.738665226832;13081;13127.540536081573;13171.934140329236;13370.465181392636;10781.975712307318;10806.891931080903;11070.5571777128;11146.984026067083;11166.33002019849;10670.83993740079;10727;10854.240203186017;10918.344899306067;10934.726631834268 06:03:06 INFO - PROCESS | 22772 | __end_tp_report 06:03:06 INFO - PROCESS | 22772 | __start_cc_report 06:03:06 INFO - PROCESS | 22772 | _x_x_mozilla_cycle_collect,1009 06:03:06 INFO - PROCESS | 22772 | __end_cc_report 06:03:06 INFO - PROCESS | 22772 | __startTimestamp1464613386761__endTimestamp 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | ------- Summary: start ------- 06:03:06 INFO - PROCESS | 22772 | Number of tests: 6 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#0] dojo.html Cycles:165 Average:5369.03 Median:5631.07 stddev:610.00 (10.8%) stddev-sans-first:586.11 06:03:06 INFO - PROCESS | 22772 | Values: 3133.2 3137.4 3144.8 3169.2 3179.5 5204.0 5272.6 5287.8 5335.0 5340.3 5322.1 5361.7 5378.6 5414.8 5434.6 4845.5 4866.6 4999.4 5039.3 5076.4 4946.6 4979.6 4991.3 5006.9 5012.8 4778.3 4818.6 4843.7 4901.6 4930.7 4921.4 4924.4 4930.3 4942.3 4981.4 4868.7 4899.8 4929.8 4930.0 4950.5 5144.5 5166.7 5248.4 5324.7 5388.3 5625.7 5653.6 5653.7 5740.1 5740.5 5751.8 5775.5 5791.5 5798.0 5803.2 5189.5 5345.5 5380.4 5382.4 5463.2 5960.5 5977.7 5979.1 5989.4 5991.9 5541.1 5680.2 5693.9 5727.2 5740.3 5639.2 5689.1 5698.1 5736.6 5739.6 5614.7 5648.8 5698.6 5707.0 5710.7 5425.2 5653.3 5660.4 5661.4 5759.9 4415.9 4425.4 4441.2 4466.2 4470.2 3937.6 3944.9 3957.4 3969.3 3983.1 5406.6 5417.5 5575.0 5579.3 5589.9 5715.9 5743.9 5748.2 5767.1 5786.5 5513.6 5514.4 5520.5 5524.8 5525.8 4843.4 4888.3 4905.6 4946.7 4948.7 5940.5 6036.6 6036.8 6040.4 6088.2 5829.2 5836.6 5841.5 5842.8 5844.2 5855.2 6048.9 6064.7 6074.1 6096.6 5773.9 5783.0 5783.6 5788.2 5829.7 5833.7 5837.6 5883.8 5898.3 5900.2 5451.0 5623.6 5638.2 5650.5 5738.7 5638.1 5647.8 5650.5 5651.7 5712.6 5633.4 5633.8 5634.7 5635.2 5642.6 5550.3 5692.2 5748.7 5761.0 5853.1 5631.1 5649.3 5658.7 5665.3 5714.3 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#1] ext.html Cycles:180 Average:62364.70 Median:229041.50 stddev:125904.48 (55.0%) stddev-sans-first:126172.23 06:03:06 INFO - PROCESS | 22772 | Values: 584.9 629.6 634.6 650.9 653.6 33057.8 43698.6 44452.0 44465.3 48600.3 44622.0 45280.8 45388.8 45437.3 45505.3 8766.6 8918.5 8929.7 8942.2 8946.6 8656.0 8773.6 8781.7 8786.0 8786.5 8802.9 8853.3 8870.2 8872.3 8876.6 8802.5 8842.6 8844.7 8848.4 8848.9 8754.5 8877.4 8886.1 8886.6 8886.9 42277.0 42752.4 42869.6 42876.4 42903.0 3415.8 3555.3 3564.2 3669.8 3936.3 30331.7 32419.2 32820.2 34244.7 34276.5 4316.3 4429.2 4473.4 4495.9 4520.6 345460.0 356334.0 356818.0 357237.0 357380.0 63840.4 64174.0 64852.7 64873.1 65002.7 58392.7 68066.0 69398.7 69654.3 69654.7 16299.9 16918.1 16942.9 17435.7 17443.7 12583.9 12723.9 12751.0 12751.4 12772.6 18027.8 19657.0 20433.9 20510.3 20631.3 7364.1 7532.6 7675.4 7723.5 7730.8 972.9 1044.8 1122.6 1161.3 1212.3 32179.0 32564.3 32613.7 32707.8 33350.8 1096.7 1126.8 1135.4 1168.0 1250.2 16947.2 16962.7 17260.6 17366.7 17527.8 519291.0 624741.0 637177.0 637660.0 637667.0 59714.4 60042.1 60204.7 60224.0 60226.0 1272.4 1353.1 1385.1 1393.7 1397.5 30791.0 32300.5 32359.8 32612.8 32953.2 51071.0 51181.7 51746.7 51824.5 51860.7 409891.0 410184.0 412154.0 413357.0 416638.0 25447.6 28683.0 29251.6 30236.4 30299.0 47394.3 47672.5 48243.5 48413.3 48736.8 40141.0 40599.6 40978.0 41350.0 41750.4 40487.0 40787.8 41059.6 41445.0 41840.2 36269.5 39995.2 40245.8 40864.4 42137.6 34427.5 37099.4 37121.8 37260.0 37406.8 28048.6 28577.6 28591.4 28645.3 28792.9 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#2] jquery.html Cycles:180 Average:30355.26 Median:13060.42 stddev:80999.62 (620.2%) stddev-sans-first:81195.59 06:03:06 INFO - PROCESS | 22772 | Values: 386.9 389.4 398.7 406.7 424.9 14076.8 16123.3 17689.8 19453.1 19522.1 18238.7 18471.4 18495.4 18962.2 19392.3 5468.4 5600.1 5648.3 5648.9 5685.8 4079.7 5444.6 5525.5 5845.8 6240.2 6204.7 6251.4 6289.4 6310.1 6318.7 6183.9 6213.4 6292.7 6292.8 6373.8 5489.9 5568.7 5608.4 5622.6 5624.5 23538.9 23669.2 23753.2 24020.4 24230.6 2367.7 2401.7 2431.5 2493.5 2524.1 14924.0 15544.7 15623.6 15733.4 16117.8 1947.3 2059.7 2070.6 2108.8 2238.8 88419.6 94266.0 94422.0 95370.0 98176.5 16863.8 18101.2 18229.8 18369.6 18443.4 32430.4 32558.3 32755.3 32819.8 32852.2 9795.1 10128.1 10148.1 10219.9 10224.6 8398.6 8449.1 8489.9 8583.4 8606.2 8897.2 9052.2 9072.9 9136.4 9302.0 3367.8 3465.3 3583.8 3584.9 3596.2 901.2 976.7 991.6 1013.2 1083.5 18766.5 19194.5 19344.0 19377.4 19707.1 983.2 993.3 993.8 1062.0 1090.9 10224.5 10532.1 10979.5 11062.4 11086.0 483386.0 486261.0 493234.0 497551.0 498821.0 67718.7 76573.0 76643.0 96741.5 99004.0 1036.2 1036.5 1069.8 1070.5 1075.2 17038.1 17051.0 17131.7 17355.4 17788.7 40478.2 41073.4 42103.0 42182.0 42237.0 55164.9 55575.0 56313.5 60518.4 60596.7 11041.6 11182.7 11544.8 11714.8 12044.0 12919.5 13183.4 13185.5 13214.3 13261.7 10947.5 11367.9 11412.1 11540.1 11572.5 11089.5 11297.7 11478.5 11539.6 11652.3 11447.4 11570.8 11595.9 11670.7 11935.6 11416.3 11489.7 11533.9 11617.5 11631.6 11528.3 11540.6 11703.6 11775.1 11863.8 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#3] mootools.html Cycles:180 Average:5847.38 Median:4823.90 stddev:3270.23 (67.8%) stddev-sans-first:3261.73 06:03:06 INFO - PROCESS | 22772 | Values: 1323.5 1501.7 1517.6 1681.9 1807.6 8383.7 8715.4 8728.1 8940.1 8948.0 8627.7 8837.8 8845.5 8851.9 8854.9 1951.1 2325.4 2384.5 2385.9 2427.3 2429.0 2432.9 2436.8 2439.6 2440.7 2319.6 2361.8 2362.5 2366.0 2367.2 1980.1 2299.3 2349.6 2351.8 2387.5 2305.9 2323.5 2331.1 2340.4 2343.4 8707.2 8808.2 8809.7 8814.7 8816.3 5278.8 5431.9 5433.9 5437.9 5440.8 3314.3 3454.0 3481.7 3483.0 3491.8 1182.9 1192.3 1247.5 1267.4 1271.2 12425.2 12426.8 12534.1 12535.2 12535.4 4715.3 4762.7 4837.9 4839.0 4864.2 9674.6 9682.4 9749.4 9751.9 9754.7 4674.2 5345.1 5357.8 5360.7 5366.1 4809.9 4899.7 4938.1 4977.2 4984.3 3813.2 3924.9 3944.7 3987.8 4024.7 1138.2 1138.7 1139.3 1160.8 1176.4 1002.6 1004.3 1024.9 1026.5 1037.2 6105.4 6139.8 6264.7 6291.4 6292.7 975.8 979.9 1010.5 1041.6 1052.8 4206.5 4313.4 4443.1 4457.6 4511.0 10295.2 10543.7 10560.6 10583.7 10591.6 10386.9 10738.2 10777.9 11025.1 11085.9 8028.4 8189.9 8191.0 8200.5 8201.1 6166.1 6380.2 6452.5 6468.7 6525.3 9875.0 10134.0 10310.9 10364.5 10389.6 10291.3 10309.5 10379.7 10388.2 10392.2 6930.7 7058.5 7862.6 7892.0 8059.6 8719.5 8770.3 8843.1 8844.2 8848.0 7623.4 7666.8 7777.5 7840.3 7948.6 7662.2 7662.3 7763.7 7883.8 7884.5 7131.9 7157.3 7160.5 7216.2 7232.6 5043.2 5084.5 5192.0 5221.2 5246.4 5169.3 5225.3 5226.0 5265.0 5382.0 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#4] prototype.html Cycles:180 Average:4525.17 Median:5059.89 stddev:1320.71 (26.1%) stddev-sans-first:1285.84 06:03:06 INFO - PROCESS | 22772 | Values: 303.3 308.6 310.2 318.5 318.8 5290.3 5359.1 5375.6 5382.4 5434.4 5250.2 5316.9 5336.5 5339.5 5345.4 4120.6 4137.9 4199.9 4210.7 4232.1 4098.9 4174.3 4180.8 4183.9 4194.3 4095.7 4121.9 4147.9 4148.5 4151.1 3916.4 4028.4 4134.2 4158.6 4163.7 3398.2 3456.4 3560.8 3561.7 3600.5 5048.1 5054.7 5056.9 5071.2 5105.3 4651.3 4662.2 4663.9 4667.0 4670.9 5234.3 5247.0 5464.8 5481.5 5526.3 3913.5 3929.3 3942.7 3958.9 3975.7 5517.6 5596.6 5817.0 5839.9 5841.5 3995.2 4010.2 4027.5 4027.7 4055.7 4077.2 4081.8 4086.1 4097.7 4117.1 4444.5 4626.4 4665.4 4666.9 4722.5 5505.9 5520.4 5531.3 5550.5 5579.9 1364.0 1379.0 1381.5 1396.7 1401.2 861.7 907.0 909.6 911.2 921.0 4854.6 4877.9 4878.8 4886.7 4891.8 5067.6 5078.4 5090.4 5093.1 5101.2 4700.6 4843.9 4872.0 4884.8 4914.2 2687.3 2697.0 2698.3 2704.6 2709.7 5273.2 5376.7 5379.7 5384.4 5394.1 4738.5 5138.5 5159.8 5202.6 5262.7 5246.9 5255.9 5274.4 5277.3 5335.8 5043.5 5050.6 5050.8 5062.8 5114.5 4845.0 4952.2 5013.6 5050.9 5067.2 5629.3 5861.2 5925.9 5949.3 6004.7 4033.4 4038.8 4069.0 4073.7 4083.9 5559.4 5655.3 5771.5 5772.6 5781.7 5506.5 5531.6 5554.9 5561.0 5625.2 5537.6 5540.5 5555.9 5556.8 5571.8 5203.5 5427.2 5482.8 5484.7 5497.2 5573.2 5575.8 5591.6 5619.7 5627.7 5288.4 5363.7 5426.5 5499.7 5505.6 06:03:06 INFO - PROCESS | 22772 | 06:03:06 INFO - PROCESS | 22772 | [#5] yui.html Cycles:180 Average:16158.78 Median:4563.59 stddev:19569.89 (428.8%) stddev-sans-first:19590.68 06:03:06 INFO - PROCESS | 22772 | Values: 773.4 797.0 799.9 806.1 853.2 14572.3 15434.8 15616.8 15635.7 15642.2 14455.3 14759.6 14764.9 15364.9 15422.7 676.4 794.4 799.3 800.7 802.2 798.2 807.3 807.5 808.3 808.5 833.8 839.3 839.8 839.9 840.8 711.6 808.3 819.7 837.1 838.1 612.5 612.9 614.8 615.0 615.3 13090.9 13100.6 13139.7 13144.5 13148.9 12922.4 13159.5 13394.6 13409.5 13743.6 12403.8 12529.2 12700.8 12733.4 12927.6 4342.7 4415.3 4452.2 4470.4 4592.5 58070.7 58342.4 58430.0 61545.7 61732.4 10457.2 10569.9 10577.8 10620.0 10793.3 18370.0 18420.4 18449.8 18464.0 18479.3 7937.6 7972.8 7994.6 8003.6 8112.4 4491.1 4557.5 4569.7 4654.7 4792.2 3332.4 3369.2 3405.7 3414.2 3418.5 550.9 607.9 612.9 621.1 628.6 600.8 603.8 604.9 665.5 682.4 9147.3 9626.2 9666.0 9804.6 9823.2 624.4 673.9 677.5 707.8 709.6 4241.2 4796.4 5019.9 5079.5 5102.1 68063.0 68629.0 70364.3 70574.0 71344.0 63413.7 64699.4 64809.7 65366.0 65578.3 58237.7 58693.0 59171.7 59343.4 59344.7 9898.5 9932.5 10053.8 10097.4 10162.7 38094.6 38246.4 38311.0 38782.0 39304.8 45426.8 52098.7 52560.5 52638.0 52803.5 12670.8 12706.6 12795.1 12937.5 13005.7 13823.4 14015.2 14191.2 14303.1 14785.6 13283.0 13620.3 13921.2 13935.4 14104.9 12818.3 12977.5 13140.4 13206.7 13469.5 13066.7 13081.0 13127.5 13171.9 13370.5 10782.0 10806.9 11070.6 11147.0 11166.3 10670.8 10727.0 10854.2 10918.3 10934.7 06:03:06 INFO - PROCESS | 22772 | -------- Summary: end -------- 06:03:06 INFO - PROCESS | 22772 | 06:03:07 INFO - TEST-INFO | 22772: exit 0 06:03:07 INFO - TEST-OK | dromaeo_css | took 1113707ms 06:03:07 INFO - TEST-START | kraken 06:03:07 INFO - operating with platform_type : linux_ 06:03:07 INFO - Initialising browser for kraken test... 06:03:07 INFO - TEST-INFO | started process 22950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvm004/profile http://localhost:54290/getInfo.html) 06:03:11 INFO - PROCESS | 22950 | __metrics Screen width/height:1600/1200 06:03:11 INFO - PROCESS | 22950 | colorDepth:24 06:03:11 INFO - PROCESS | 22950 | Browser inner width/height: 1024/697 06:03:11 INFO - PROCESS | 22950 | __metrics 06:03:12 ERROR - PROCESS | 22950 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:03:13 INFO - TEST-INFO | 22950: exit 0 06:03:13 INFO - Browser initialized. 06:03:13 INFO - Running cycle 1/1 for kraken test... 06:03:13 INFO - TEST-INFO | started process 23028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvm004/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:25 INFO - PROCESS | 23028 | RSS: Main: 155377664 06:03:25 INFO - PROCESS | 23028 | 06:03:27 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54290/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:28 INFO - PROCESS | 23028 | RSS: Main: 214241280 06:03:28 INFO - PROCESS | 23028 | 06:03:31 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54290/tests/kraken/driver.html?testName=audio-dft) 06:03:32 INFO - PROCESS | 23028 | RSS: Main: 198135808 06:03:32 INFO - PROCESS | 23028 | 06:03:35 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54290/tests/kraken/driver.html?testName=audio-fft) 06:03:35 INFO - PROCESS | 23028 | RSS: Main: 268804096 06:03:35 INFO - PROCESS | 23028 | 06:03:37 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54290/tests/kraken/driver.html?testName=audio-oscillator) 06:03:38 INFO - PROCESS | 23028 | RSS: Main: 179175424 06:03:38 INFO - PROCESS | 23028 | 06:03:40 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:41 INFO - PROCESS | 23028 | RSS: Main: 184066048 06:03:41 INFO - PROCESS | 23028 | 06:03:44 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54290/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:44 INFO - PROCESS | 23028 | RSS: Main: 218005504 06:03:44 INFO - PROCESS | 23028 | 06:03:48 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54290/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:48 INFO - PROCESS | 23028 | RSS: Main: 220082176 06:03:48 INFO - PROCESS | 23028 | 06:03:51 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54290/tests/kraken/driver.html?testName=json-parse-financial) 06:03:52 INFO - PROCESS | 23028 | RSS: Main: 220700672 06:03:52 INFO - PROCESS | 23028 | 06:03:53 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:54 INFO - PROCESS | 23028 | RSS: Main: 208789504 06:03:54 INFO - PROCESS | 23028 | 06:03:56 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:56 INFO - PROCESS | 23028 | RSS: Main: 210436096 06:03:56 INFO - PROCESS | 23028 | 06:03:58 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:59 INFO - PROCESS | 23028 | RSS: Main: 218386432 06:03:59 INFO - PROCESS | 23028 | 06:04:01 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:02 INFO - PROCESS | 23028 | RSS: Main: 222150656 06:04:02 INFO - PROCESS | 23028 | 06:04:05 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:05 INFO - PROCESS | 23028 | RSS: Main: 223326208 06:04:05 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:54290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54290/tests/kraken/driver.html?testName=ai-astar) 06:04:07 INFO - PROCESS | 23028 | RSS: Main: 265445376 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | __start_tp_report 06:04:07 INFO - PROCESS | 23028 | _x_x_mozilla_page_load 06:04:07 INFO - PROCESS | 23028 | _x_x_mozilla_page_load_details 06:04:07 INFO - PROCESS | 23028 | |i|pagename|runs| 06:04:07 INFO - PROCESS | 23028 | |0;ai-astar;111;104;110;110;110;110;109;109;112;109 06:04:07 INFO - PROCESS | 23028 | |1;audio-beat-detection;150;132;126;170;131;126;159;124;194;126 06:04:07 INFO - PROCESS | 23028 | |2;audio-dft;160;161;160;159;158;160;160;160;160;160 06:04:07 INFO - PROCESS | 23028 | |3;audio-fft;76;74;75;122;75;76;75;74;96;74 06:04:07 INFO - PROCESS | 23028 | |4;audio-oscillator;82;82;107;83;83;84;121;82;84;125 06:04:07 INFO - PROCESS | 23028 | |5;imaging-gaussian-blur;116;116;117;116;116;117;117;117;116;116 06:04:07 INFO - PROCESS | 23028 | |6;imaging-darkroom;146;146;145;145;145;146;145;145;145;146 06:04:07 INFO - PROCESS | 23028 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;94;94 06:04:07 INFO - PROCESS | 23028 | |8;json-parse-financial;56;53;58;55;54;57;56;56;55;55 06:04:07 INFO - PROCESS | 23028 | |9;json-stringify-tinderbox;64;63;62;62;62;64;63;63;63;62 06:04:07 INFO - PROCESS | 23028 | |10;stanford-crypto-aes;79;79;84;79;80;81;79;79;109;79 06:04:07 INFO - PROCESS | 23028 | |11;stanford-crypto-ccm;122;128;133;128;131;130;125;120;139;123 06:04:07 INFO - PROCESS | 23028 | |12;stanford-crypto-pbkdf2;166;164;162;158;162;158;159;160;160;162 06:04:07 INFO - PROCESS | 23028 | |13;stanford-crypto-sha256-iterative;63;62;63;64;64;62;63;62;63;61 06:04:07 INFO - PROCESS | 23028 | __end_tp_report 06:04:07 INFO - PROCESS | 23028 | __start_cc_report 06:04:07 INFO - PROCESS | 23028 | _x_x_mozilla_cycle_collect,1634 06:04:07 INFO - PROCESS | 23028 | __end_cc_report 06:04:07 INFO - PROCESS | 23028 | __startTimestamp1464613447753__endTimestamp 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | ------- Summary: start ------- 06:04:07 INFO - PROCESS | 23028 | Number of tests: 14 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.17 06:04:07 INFO - PROCESS | 23028 | Values: 111.0 104.0 110.0 110.0 110.0 110.0 109.0 109.0 112.0 109.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:141.00 stddev:23.86 (16.9%) stddev-sans-first:25.20 06:04:07 INFO - PROCESS | 23028 | Values: 150.0 132.0 126.0 170.0 131.0 126.0 159.0 124.0 194.0 126.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:04:07 INFO - PROCESS | 23028 | Values: 160.0 161.0 160.0 159.0 158.0 160.0 160.0 160.0 160.0 160.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:15.66 (20.9%) stddev-sans-first:16.47 06:04:07 INFO - PROCESS | 23028 | Values: 76.0 74.0 75.0 122.0 75.0 76.0 75.0 74.0 96.0 74.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:82.50 stddev:17.41 (21.1%) stddev-sans-first:17.98 06:04:07 INFO - PROCESS | 23028 | Values: 82.0 82.0 107.0 83.0 83.0 84.0 121.0 82.0 84.0 125.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:04:07 INFO - PROCESS | 23028 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:04:07 INFO - PROCESS | 23028 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:04:07 INFO - PROCESS | 23028 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 06:04:07 INFO - PROCESS | 23028 | Values: 56.0 53.0 58.0 55.0 54.0 57.0 56.0 56.0 55.0 55.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 06:04:07 INFO - PROCESS | 23028 | Values: 64.0 63.0 62.0 62.0 62.0 64.0 63.0 63.0 63.0 62.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:79.00 stddev:9.34 (11.8%) stddev-sans-first:9.81 06:04:07 INFO - PROCESS | 23028 | Values: 79.0 79.0 84.0 79.0 80.0 81.0 79.0 79.0 109.0 79.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:5.70 (4.4%) stddev-sans-first:5.64 06:04:07 INFO - PROCESS | 23028 | Values: 122.0 128.0 133.0 128.0 131.0 130.0 125.0 120.0 139.0 123.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:162.00 stddev:2.60 (1.6%) stddev-sans-first:2.07 06:04:07 INFO - PROCESS | 23028 | Values: 166.0 164.0 162.0 158.0 162.0 158.0 159.0 160.0 160.0 162.0 06:04:07 INFO - PROCESS | 23028 | 06:04:07 INFO - PROCESS | 23028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 06:04:07 INFO - PROCESS | 23028 | Values: 63.0 62.0 63.0 64.0 64.0 62.0 63.0 62.0 63.0 61.0 06:04:07 INFO - PROCESS | 23028 | -------- Summary: end -------- 06:04:07 INFO - PROCESS | 23028 | 06:04:08 INFO - TEST-INFO | 23028: exit 0 06:04:08 INFO - TEST-OK | kraken | took 61174ms 06:04:08 INFO - SUITE-END | took 1174s 06:04:08 INFO - Completed test suite (00:19:35) 06:04:08 INFO - javascript benchmark 06:04:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.248020475087, 3137.419577378185, 3144.779865409421, 3169.176014236301, 3179.538966849807, 5203.973980130104, 5272.604554658406, 5287.814926477574, 5335.039692855289, 5340.332458442699, 5322.148456247001, 5361.678299302035, 5378.596605254602, 5414.810481633143, 5434.646747961389, 4845.466998630157, 4866.6106711463, 4999.425066117388, 5039.344885164924, 5076.36545431821, 4946.629002824785, 4979.626528010395, 4991.251312303148, 5006.949930500703, 5012.82455114071, 4778.25936979767, 4818.638602104857, 4843.66094373394, 4901.632377571678, 4930.654854160211, 4921.434035085975, 4924.384451943507, 4930.260460930889, 4942.308076869242, 4981.37732783402, 4868.683535570212, 4899.779509922062, 4929.827456039057, 4930.03864246472, 4950.455449900508, 5144.511271429208, 5166.689998600096, 5248.422673505911, 5324.7071411072375, 5388.299521062276, 5625.746841392147, 5653.604247702662, 5653.660780353151, 5740.138979153118, 5740.54075673945, 5751.769929202868, 5775.537956963475, 5791.507721843648, 5797.971010144965, 5803.187553742479, 5189.455107213726, 5345.465453454663, 5380.408155102936, 5382.354117505885, 5463.2078348639225, 5960.493358064527, 5977.671228082497, 5979.133025711248, 5989.401059894063, 5991.940080599138, 5541.085720856095, 5680.176374425685, 5693.914591281051, 5727.198192253005, 5740.253767010262, 5639.182318563868, 5689.118186681071, 5698.145278208219, 5736.598438109292, 5739.62692424991, 5614.6631202128, 5648.78551111513, 5698.572607054488, 5706.9714651426475, 5710.65736055838, 5425.186222066643, 5653.349864765522, 5660.433956604306, 5661.377248502661, 5759.8560035999435, 4415.933760993587, 4425.402570652921, 4441.156180325728, 4466.173757854807, 4470.195364834296, 3937.6062393760967, 3944.881653550398, 3957.445957565943, 3969.3450580654444, 3983.083890705096, 5406.648567843077, 5417.5395091416885, 5575.024370735106, 5579.302587176603, 5589.8602534936135, 5715.942840571541, 5743.8564035899435, 5748.223989761413, 5767.106098554731, 5786.450287222707, 5513.641613295123, 5514.36584792754, 5520.530754885799, 5524.8342549723575, 5525.751341189656, 4843.370361852936, 4888.315635810989, 4905.607551395879, 4946.727929963887, 4948.703077815343, 5940.4653581177035, 6036.63780173191, 6036.788712395045, 6040.36576159497, 6088.208532890696, 5829.15477255804, 5836.649801011953, 5841.474267315962, 5842.824715258549, 5844.15259787337, 5855.23881895368, 6048.90926636092, 6064.666443345658, 6074.088886667036, 6096.634201947897, 5773.884522309446, 5783.045797443543, 5783.624064435799, 5788.247527821356, 5829.708514574169, 5833.67914764692, 5837.6497410155525, 5883.823485295448, 5898.262717160355, 5900.203472531153, 5450.972745136249, 5623.606347555632, 5638.182463542681, 5650.463205995424, 5738.713064346849, 5638.097904335286, 5647.802326918538, 5650.519705824887, 5651.717414129359, 5712.6286791358425, 5633.4084921082695, 5633.8309850704545, 5634.690092044977, 5635.182898479616, 5642.633228840113, 5550.333959924835, 5692.231548740867, 5748.683822389641, 5761.049426844524, 5853.0635098384055, 5631.070873305859, 5649.293838270216, 5658.717064146694, 5665.263515743092, 5714.257146570919], "value": 5328.188673144431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.868404608963, 629.6033498895695, 634.6128861394549, 650.9218893732752, 653.6404977262505, 33057.83471082644, 43698.56301436984, 44452.0, 44465.33302000473, 48600.270995935, 44622.0, 45280.77359613206, 45388.773056134756, 45437.318440223426, 45505.31742023864, 8766.649334026632, 8918.464892106495, 8929.73210803677, 8942.239909607692, 8946.64213431462, 8655.95672021639, 8773.56132193391, 8781.736547903573, 8786.033536311, 8786.516741579211, 8802.86795698065, 8853.291736661084, 8870.201681848632, 8872.290216782641, 8876.556172191396, 8802.515861627608, 8842.557872106368, 8844.690435834715, 8848.424852384607, 8848.911510884873, 8754.518501482416, 8877.422967507091, 8886.066962968924, 8886.644534218623, 8886.911130888673, 42277.0, 42752.3587146193, 42869.57130428687, 42876.35685464721, 42903.0, 3415.8292085395633, 3555.3422616815974, 3564.233689756689, 3669.7798132112157, 3936.291467535871, 30331.696683033108, 32419.189520261945, 32820.179495512566, 34244.657553424644, 34276.48585271223, 4316.330968699856, 4429.247028005247, 4473.3960915276675, 4495.865124046284, 4520.570545798144, 345460.0, 356333.9999999974, 356818.0, 357237.0, 357380.0, 63840.36159638344, 64174.0, 64852.67573662196, 64873.05380838583, 65002.67498662571, 58392.708036459546, 68066.0, 69398.65300673565, 69654.30345696479, 69654.65172674104, 16299.918500407422, 16918.06950617703, 16942.915285423493, 17435.73846392305, 17443.73834392485, 12583.874161258453, 12723.936380318039, 12751.043671724658, 12751.36243187837, 12772.61682149537, 18027.819721802876, 19657.03429657023, 20433.897830510752, 20510.282140125324, 20631.277905273244, 7364.116306043309, 7532.585707786125, 7675.42873137494, 7723.459357844897, 7730.806729831799, 972.9075737804898, 1044.8484969679505, 1122.6014764758393, 1161.3148242536943, 1212.2847519963263, 32179.0, 32564.34871302608, 32613.673863261065, 32707.83646081802, 33350.833245833615, 1096.7313008313015, 1126.7690123524658, 1135.3868910788083, 1167.9824802627968, 1250.1623911978995, 16947.237374317938, 16962.660746784994, 17260.568485787957, 17366.700765987076, 17527.824721752873, 519291.0, 624741.0, 637177.0, 637660.0, 637667.0, 59714.402855971755, 60042.09936850951, 60204.698976504835, 60224.0, 60226.0, 1272.3765354975994, 1353.1204716933876, 1385.1273697570668, 1393.7212557488542, 1397.475946520055, 30791.0, 32300.515492268103, 32359.838200808845, 32612.83693581517, 32953.17617059593, 51071.0, 51181.7440912793, 51746.74126629343, 51824.48175518347, 51860.740696297784, 409891.0, 410184.0, 412154.0, 413357.0, 416638.0, 25447.6182857261, 28683.0, 29251.561226582045, 30236.395272094876, 30299.0, 47394.289085663055, 47672.523274766805, 48243.5175648239, 48413.27380089231, 48736.75631621961, 40141.0, 40599.59400405958, 40978.0, 41350.0, 41750.37374439446, 40487.0, 40787.79606101951, 41059.58940410558, 41445.0, 41840.16319673529, 36269.45595816012, 39995.20009599734, 40245.79877100596, 40864.387034195104, 42137.57862421337, 34427.483587746705, 37099.44350834793, 37121.81439092787, 37260.0, 37406.812965934994, 28048.57927131054, 28577.571336429555, 28591.42817143687, 28645.283867902635, 28792.856035719687], "value": 20540.78771997044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.8994061543998, 389.35950361655097, 398.7408184679958, 406.7417190084296, 424.93201087825935, 14076.788848167285, 16123.27445264963, 17689.823101768994, 19453.12460939256, 19522.121504532293, 18238.726419103692, 18471.445856624323, 18495.35266265681, 18962.241510339605, 19392.321268755597, 5468.425815289397, 5600.075987462084, 5648.293963254593, 5648.915266271009, 5685.772569097231, 4079.6940229482757, 5444.564434845222, 5525.475079867406, 5845.766169353242, 6240.188775459206, 6204.689765511729, 6251.374862513735, 6289.37106289372, 6310.053491976194, 6318.71565779541, 6183.87632247357, 6213.409726076015, 6292.685365731695, 6292.842678933041, 6373.808785736435, 5489.890202195974, 5568.7215639217875, 5608.411116832755, 5622.606417550773, 5624.493795558419, 23538.940747666395, 23669.171578994825, 23753.168639097723, 24020.399490012715, 24230.636540451906, 2367.6685264063044, 2401.6877805885297, 2431.489387228684, 2493.488834788864, 2524.0534799450206, 14924.0, 15544.689106217926, 15623.609409764847, 15733.449329273535, 16117.838821611751, 1947.2795065825594, 2059.721937538428, 2070.637638413287, 2108.7574928883223, 2238.8432809703327, 88419.55790221073, 94266.0, 94422.0, 95370.0, 98176.50911745467, 16863.831361686473, 18101.18988101206, 18229.817701823078, 18369.63260734778, 18443.446696599123, 32430.35139297248, 32558.34883302368, 32755.34489310248, 32819.83590082034, 32852.178695532326, 9795.118439340351, 10128.139108175741, 10148.137408320228, 10219.9489002556, 10224.59101635941, 8398.580070996426, 8449.112843151504, 8489.915100849035, 8583.399162058597, 8606.182412670787, 8897.199252067345, 9052.23056040244, 9072.8639070414, 9136.360454768235, 9302.0, 3367.830380366126, 3465.2722928185362, 3583.8387272572795, 3584.8632446609217, 3596.2088340565033, 901.1799262670938, 976.6581696406201, 991.5686676295834, 1013.2147585621055, 1083.539495714334, 18766.49868010556, 19194.52013699641, 19344.0, 19377.4186774397, 19707.113179906937, 983.2085171437062, 993.2500961773815, 993.8360170571775, 1061.9893801062044, 1090.8654998801157, 10224.488775561193, 10532.10477109439, 10979.505922233519, 11062.446877656084, 11086.0, 483386.0, 486261.0, 493234.0, 497551.0, 498821.0, 67718.66140669266, 76573.0, 76643.0, 96741.51629241949, 99004.0, 1036.1917704190744, 1036.4558606731525, 1069.7967386196597, 1070.5182667799522, 1075.2097208551709, 17038.14809259557, 17051.0, 17131.657366852844, 17355.392561260294, 17788.733169002215, 40478.1904361917, 41073.38389924213, 42103.0, 42182.0, 42237.0, 55164.903236119084, 55575.0, 56313.46589403569, 60518.394816051274, 60596.697016514634, 11041.558337666404, 11182.720431989266, 11544.82682759776, 11714.824277636013, 12044.0, 12919.483220671067, 13183.406746696613, 13185.472581097032, 13214.339283035617, 13261.734765304447, 10947.507362168562, 11367.943160284476, 11412.144089193178, 11540.076793856304, 11572.479238434122, 11089.518461715117, 11297.661070167907, 11478.483468244116, 11539.596114135966, 11652.30086194831, 11447.427628618369, 11570.76858462843, 11595.897804965787, 11670.70823229426, 11935.582254621047, 11416.257943233662, 11489.655310340702, 11533.94233028863, 11617.535298587962, 11631.59289424866, 11528.308301501937, 11540.596079137189, 11703.590374337198, 11775.133572005376, 11863.822042669539], "value": 10306.118245568956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.4671250965453, 1501.7146742118994, 1517.5902506323293, 1681.9074950877705, 1807.5842556212071, 8383.706570270035, 8715.389922705404, 8728.083551227117, 8940.105989401056, 8948.015718270985, 8627.741167764978, 8837.779055523615, 8845.513496757692, 8851.91148088519, 8854.86717699235, 1951.112243929016, 2325.4418939454577, 2384.5350156719446, 2385.916492922748, 2427.2718184544656, 2428.9878550607223, 2432.8783560821976, 2436.7806897379232, 2439.5852705040184, 2440.707115146176, 2319.617263151578, 2361.7756313150308, 2362.5156842847173, 2366.0417530900013, 2367.183321753992, 1980.1188471130354, 2299.3217000984664, 2349.553584818879, 2351.7648235176516, 2387.5344307859973, 2305.919292824743, 2323.453988312745, 2331.1141766128762, 2340.4265954841003, 2343.379004563792, 8707.216350528419, 8808.207261346446, 8809.691660791841, 8814.735557933273, 8816.338774591932, 5278.762455689503, 5431.945680543184, 5433.864153396157, 5437.891242175174, 5440.809571664972, 3314.254292784128, 3454.0, 3481.686648201674, 3483.0073429072845, 3491.8428670709627, 1182.8639706433785, 1192.2825729340111, 1247.5134697467995, 1267.3789842976967, 1271.1927925767204, 12425.19236249641, 12426.751464970741, 12534.122611417204, 12535.24788512692, 12535.373231338397, 4715.339852420664, 4762.666613337033, 4837.879053023703, 4839.0, 4864.246041863516, 9674.613015479443, 9682.370645907993, 9749.36629119105, 9751.90248097524, 9754.707358779247, 4674.158651442773, 5345.091334473149, 5357.8392648220615, 5360.678359298455, 5366.141417373202, 4809.927851082237, 4899.706017638953, 4938.111139994836, 4977.203647416396, 4984.27727979441, 3813.218290250492, 3924.862629807943, 3944.723869329119, 3987.8404863805704, 4024.6981476389387, 1138.2373809547623, 1138.6584024792528, 1139.3107170162098, 1160.802663547199, 1176.4470698771563, 1002.5638847101388, 1004.3371374892536, 1024.8872624011353, 1026.5483187397522, 1037.1547189040907, 6105.419985101408, 6139.815805525842, 6264.718087686065, 6291.433770960635, 6292.748290068346, 975.7511834482161, 979.8775153105862, 1010.5351538292468, 1041.6250149946013, 1052.752603138262, 4206.537280899099, 4313.374560688682, 4443.089166720814, 4457.598816106566, 4510.954890451054, 10295.176385889112, 10543.736406589896, 10560.630377936735, 10583.682489525327, 10591.57633694659, 10386.948065259625, 10738.248322617343, 10777.946110269399, 11025.117990560735, 11085.889141108486, 8028.397870159762, 8189.918100818915, 8191.0, 8200.507969521848, 8201.13888041759, 6166.105914642262, 6380.202474690664, 6452.451541619015, 6468.676566171766, 6525.347465253437, 9875.0, 10134.037266459674, 10310.896891031294, 10364.481775911023, 10389.584416623251, 10291.33106348085, 10309.536070876979, 10379.688609341732, 10388.220883433622, 10392.16862650971, 6930.7227710891, 7058.470614704021, 7862.646180921986, 7892.0, 8059.556724379981, 8719.476831390137, 8770.342224333073, 8843.07147749477, 8844.248238899765, 8848.026717061246, 7623.428242881695, 7666.846663066596, 7777.533347999138, 7840.3335716464735, 7948.562829044458, 7662.233776622516, 7662.272084151997, 7763.68945242184, 7883.802904927423, 7884.487508311941, 7131.928680713127, 7157.284271572801, 7160.498765086394, 7216.170140433917, 7232.63836808147, 5043.2435134730085, 5084.542391184811, 5192.0, 5221.242919776687, 5246.396664383492, 5169.276301317744, 5225.320708307896, 5226.0, 5264.9736751315995, 5382.0], "value": 4702.146786912957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.29332654914055, 308.56954548404974, 310.2244389027431, 318.47928636679023, 318.80712169137684, 5290.285811415458, 5359.142537194045, 5375.569954403653, 5382.3852844146695, 5434.429384914586, 5250.18622113572, 5316.893662126765, 5336.466353364662, 5339.492748188916, 5345.385280692722, 4120.567340429249, 4137.924139723664, 4199.874003779892, 4210.705250632457, 4232.068944832132, 4098.918021639565, 4174.332106862903, 4180.79096045198, 4183.874483765492, 4194.273722080641, 4095.685937445334, 4121.9381709274385, 4147.854825081123, 4148.481439820022, 4151.086760912594, 3916.353801622729, 4028.4158796974566, 4134.2144992451485, 4158.627652874544, 4163.666906647461, 3398.235397035647, 3456.412409890325, 3560.8041557714573, 3561.679448849616, 3600.513930619385, 5048.1418158913075, 5054.671446355975, 5056.924146137811, 5071.2139618359215, 5105.310783044279, 4651.279051746985, 4662.230731929228, 4663.860084197479, 4666.95333046672, 4670.883227919295, 5234.345706786652, 5247.02929957959, 5464.797744496204, 5481.534069604048, 5526.253955715967, 3913.4521167036637, 3929.2534418460687, 3942.6989093599045, 3958.920821583581, 3975.6819454443576, 5517.5585953123655, 5596.552275817966, 5817.0, 5839.8540036499, 5841.474267315962, 3995.20095980805, 4010.2380547695843, 4027.496562929634, 4027.6708686133506, 4055.736377135536, 4077.1845630873945, 4081.7959102045374, 4086.1010577672864, 4097.651699605567, 4117.053077792065, 4444.511103778582, 4626.421697287839, 4665.370175026396, 4666.906661866744, 4722.504137065627, 5505.862353441116, 5520.3651580068, 5531.3362396511875, 5550.500454958992, 5579.9163012554845, 1363.9795403068963, 1378.97266536431, 1381.5026590427437, 1396.7136736968896, 1401.1943132698739, 861.7285555050139, 906.9818603628022, 909.5770466732869, 911.2072496927583, 920.9593159729462, 4854.5873600744335, 4877.878053048631, 4878.780454879468, 4886.706797592155, 4891.779869905863, 5067.569256613156, 5078.390593128848, 5090.389153301628, 5093.134167191586, 5101.20931255656, 4700.647451441156, 4843.903121937541, 4871.952530206023, 4884.8290309838985, 4914.238293064581, 2687.314734742667, 2697.0, 2698.3389069678055, 2704.580789977557, 2709.7425744554234, 5273.233466788669, 5376.7042812644895, 5379.731013449312, 5384.434634363335, 5394.083005889008, 4738.502457242009, 5138.511841375063, 5159.7678104485385, 5202.606800871566, 5262.710550919736, 5246.895062098737, 5255.947440525699, 5274.446183150791, 5277.258504693442, 5335.785648955718, 5043.52086551777, 5050.646454748133, 5050.797968081236, 5062.848114556422, 5114.4629813869005, 4845.0, 4952.2306512912055, 5013.573846223112, 5050.873728156826, 5067.214581739836, 5629.296337957755, 5861.208736820645, 5925.911111333247, 5949.25634295713, 6004.699765011819, 4033.3546632538655, 4038.818253178673, 4068.9796551017057, 4073.735207211522, 4083.8570650027104, 5559.388467268678, 5655.321361436654, 5771.509421699203, 5772.624779389326, 5781.739821707949, 5506.485716428015, 5531.593756715842, 5554.888902222014, 5561.0, 5625.240592520121, 5537.5569954402745, 5540.473655002768, 5555.861103472445, 5556.833295001156, 5571.774209673866, 5203.505666961632, 5427.158790387496, 5482.780688772405, 5484.698341591251, 5497.230387745799, 5573.1918871762555, 5575.832725018256, 5591.608587398843, 5619.690916999604, 5627.705627705569, 5288.365396152486, 5363.651362661414, 5426.457354264542, 5499.697516636464, 5505.587080969023], "value": 4099.015503683569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.3697036914914, 796.9760907172783, 799.9400044996625, 806.1132753970637, 853.2363534636501, 14572.271386430675, 15434.845651543481, 15616.76574851378, 15635.687286254268, 15642.217889105556, 14455.277236138178, 14759.631009224748, 14764.852351476482, 15364.923175384136, 15422.69154616907, 676.3777324861139, 794.3526026288586, 799.348530947279, 800.7037396163413, 802.2378740196837, 798.2017982017982, 807.3258828877894, 807.4912804932884, 808.3048578222753, 808.5270116981573, 833.8165603567205, 839.3369238301734, 839.7984483723924, 839.8698201778734, 840.794005468661, 711.6086152616066, 808.2644793238184, 819.7090033038245, 837.0792128658458, 838.1325328285226, 612.4610342898221, 612.9448349648553, 614.7602435050334, 615.0374663651415, 615.3047056825803, 13090.934545327307, 13100.60698179056, 13139.671508212276, 13144.539941102015, 13148.934255328662, 12922.353882305848, 13159.53941612039, 13394.598162055154, 13409.46362145513, 13743.587692369245, 12403.813942790865, 12529.185602935871, 12700.80948785769, 12733.426995785212, 12927.612171634866, 4342.652587792969, 4415.271480205794, 4452.154090722753, 4470.396496472967, 4592.494825569184, 58070.70964645192, 58342.416575834126, 58430.0, 61545.69227153881, 61732.38267617356, 10457.215708821868, 10569.894301057046, 10577.84133238002, 10620.0, 10793.29843560166, 18370.0, 18420.35528756487, 18449.81550184481, 18464.0, 18479.260829566934, 7937.603119843985, 7972.760817175494, 7994.560299183485, 8003.639836207385, 8112.391570632226, 4491.124230774967, 4557.453105627346, 4569.725816451024, 4654.697444666086, 4792.185328494164, 3332.3668502984356, 3369.2419205678525, 3405.6934875861293, 3414.231797845465, 3418.504316874089, 550.8953298873201, 607.8541150124026, 612.8774245150987, 621.1056079245961, 628.6165439082156, 600.7566935391174, 603.7584966013542, 604.8760004199129, 665.5108495255982, 682.3654001778294, 9147.2682185425, 9626.229901607854, 9666.0, 9804.558794854105, 9823.214142868554, 624.4224092714221, 673.8820706376365, 677.4546490075536, 707.7912015955305, 709.5848928376957, 4241.194173107161, 4796.424429068534, 5019.924701129486, 5079.466656001141, 5102.081625307406, 68063.0, 68629.0, 70364.2963570368, 70574.0, 71344.0, 63413.68293158505, 64699.35300646933, 64809.67595161994, 65366.0, 65578.34421655722, 58237.70881145567, 58693.0, 59171.70414147988, 59343.40656593465, 59344.70327648334, 9898.505074746377, 9932.503374831085, 10053.849192261976, 10097.44464054484, 10162.745931351776, 38094.61905380911, 38246.42630360602, 38311.04222394351, 38782.0, 39304.80347598244, 45426.77286613678, 52098.73950630223, 52560.47439525556, 52638.0, 52803.47196527985, 12670.809937850756, 12706.618801435972, 12795.104342696295, 12937.54718584845, 13005.674858128623, 13823.377947992565, 14015.229162396166, 14191.219482928538, 14303.07030043044, 14785.556433307018, 13283.0, 13620.31898405056, 13921.164730116225, 13935.442582296595, 14104.929475352557, 12818.294993775431, 12977.545785897448, 13140.408681609159, 13206.735865282833, 13469.49686157261, 13066.738665226832, 13081.0, 13127.540536081573, 13171.934140329236, 13370.465181392636, 10781.975712307318, 10806.891931080903, 11070.5571777128, 11146.984026067083, 11166.33002019849, 10670.83993740079, 10727.0, 10854.240203186017, 10918.344899306067, 10934.726631834268], "value": 6970.731259227951, "unit": "score"}], "name": "dromaeo_css", "value": 7301.841535162197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 112.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 126.0, 170.0, 131.0, 126.0, 159.0, 124.0, 194.0, 126.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 158.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 122.0, 75.0, 76.0, 75.0, 74.0, 96.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 83.0, 83.0, 84.0, 121.0, 82.0, 84.0, 125.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 58.0, 55.0, 54.0, 57.0, 56.0, 56.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 79.0, 80.0, 81.0, 79.0, 79.0, 109.0, 79.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 133.0, 128.0, 131.0, 130.0, 125.0, 120.0, 139.0, 123.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 158.0, 162.0, 158.0, 159.0, 160.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 64.0, 62.0, 63.0, 62.0, 63.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1497.2, "alertThreshold": 2.0}]} 06:04:09 INFO - Return code: 0 06:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:09 ERROR - # TBPL SUCCESS # 06:04:09 INFO - Running post-action listener: _resource_record_post_action 06:04:09 INFO - ##### 06:04:09 INFO - ##### Finished run-tests step (success) 06:04:09 INFO - ##### 06:04:09 INFO - Running post-run listener: _resource_record_post_run 06:04:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 538636288; Read time: 200; Write time: 425956 06:04:09 INFO - TinderboxPrint: CPU usage
13.2% 06:04:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 200 06:04:09 INFO - TinderboxPrint: I/O write bytes / time
538,636,288 / 425,956 06:04:09 INFO - TinderboxPrint: CPU idle
8,261.6 (86.8%) 06:04:09 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 06:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:04:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247402496; Read time: 0; Write time: 217100 06:04:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291233792; Read time: 200; Write time: 208856 06:04:09 INFO - Running post-run listener: _upload_blobber_files 06:04:09 INFO - Blob upload gear active. 06:04:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:09 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 06:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:10 INFO - (blobuploader) - INFO - Done attempting. 06:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:15 INFO - (blobuploader) - INFO - Done attempting. 06:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:15 INFO - (blobuploader) - INFO - Done attempting. 06:04:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:15 INFO - Return code: 0 06:04:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4096fa1a4ea4e6c76084b4c671b80cf5f1dc84d3acec341476d345732e221f02032c1202b25999ad51eca85889035ad0534224e7de2831151fe70e6c9066b72d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8916a613cf59546892df25fbf5f05be7cb39f2fd1de573900a2c85da0946ab2fd381179ae9ecc5335a970512c7f583afaf91b2c1dd41d4b04fbc73ddee7fd3fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfed9c70ca82896e3707394c8142a54d223770d2b9e3bbe749e3968dfe8024a5ed8000ad9414d00e467ce8d85ebceddbb11f7b2b072ba245ab2c3e6bcecb61"} 06:04:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:15 INFO - Contents: 06:04:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4096fa1a4ea4e6c76084b4c671b80cf5f1dc84d3acec341476d345732e221f02032c1202b25999ad51eca85889035ad0534224e7de2831151fe70e6c9066b72d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8916a613cf59546892df25fbf5f05be7cb39f2fd1de573900a2c85da0946ab2fd381179ae9ecc5335a970512c7f583afaf91b2c1dd41d4b04fbc73ddee7fd3fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfed9c70ca82896e3707394c8142a54d223770d2b9e3bbe749e3968dfe8024a5ed8000ad9414d00e467ce8d85ebceddbb11f7b2b072ba245ab2c3e6bcecb61"} 06:04:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:15 INFO - Copying logs to upload dir... 06:04:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.422268 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-30 06:04:15.840767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:04:15.843973) ========= 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=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4096fa1a4ea4e6c76084b4c671b80cf5f1dc84d3acec341476d345732e221f02032c1202b25999ad51eca85889035ad0534224e7de2831151fe70e6c9066b72d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8916a613cf59546892df25fbf5f05be7cb39f2fd1de573900a2c85da0946ab2fd381179ae9ecc5335a970512c7f583afaf91b2c1dd41d4b04fbc73ddee7fd3fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfed9c70ca82896e3707394c8142a54d223770d2b9e3bbe749e3968dfe8024a5ed8000ad9414d00e467ce8d85ebceddbb11f7b2b072ba245ab2c3e6bcecb61"} build_url:https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/OJQfXbtCTauz4t0fcy1hnQ/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/Firefox/sha512/4096fa1a4ea4e6c76084b4c671b80cf5f1dc84d3acec341476d345732e221f02032c1202b25999ad51eca85889035ad0534224e7de2831151fe70e6c9066b72d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8916a613cf59546892df25fbf5f05be7cb39f2fd1de573900a2c85da0946ab2fd381179ae9ecc5335a970512c7f583afaf91b2c1dd41d4b04fbc73ddee7fd3fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfed9c70ca82896e3707394c8142a54d223770d2b9e3bbe749e3968dfe8024a5ed8000ad9414d00e467ce8d85ebceddbb11f7b2b072ba245ab2c3e6bcecb61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:04:15.869083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:04:15.869445) ========= 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=574dc5aafe09851ec43d388c000001b6-1464610745.957242-1437796315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:04:15.951410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:04:15.951741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:04:15.952029) ========= ========= Total master_lag: 0.15 =========