builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1464353237.68 results: success (0) buildid: 20160527030220 builduid: abfda7b12b6f40ce8231055758352076 revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.680271) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.680754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.681145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.699994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.700341) ========= 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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 05:47: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% 229M=0s 2016-05-27 05:47:18 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.868406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.868760) ========= 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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020573 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:17.918278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 05:47:17.918634) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d63dde701b47b8661ab7990f197b6b60e543839 --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 4d63dde701b47b8661ab7990f197b6b60e543839 --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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 05:47:18,280 truncating revision to first 12 chars 2016-05-27 05:47:18,280 Setting DEBUG logging. 2016-05-27 05:47:18,280 attempt 1/10 2016-05-27 05:47:18,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d63dde701b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 05:47:19,298 unpacking tar archive at: mozilla-central-4d63dde701b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 05:47:19.314093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:19.314441) ========= script_repo_revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:19.314896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:19.315211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 05:47:19.325671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-27 05:47:19.326027) ========= /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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:19 INFO - MultiFileLogger online at 20160527 05:47:19 in /builds/slave/test 05:47: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:47:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:19 INFO - {'append_to_log': False, 05:47:19 INFO - 'base_work_dir': '/builds/slave/test', 05:47:19 INFO - 'blob_upload_branch': 'Firefox', 05:47:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:19 INFO - 'branch': 'Firefox', 05:47:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:19 INFO - 'config_files': ('talos/linux_config.py',), 05:47:19 INFO - 'default_actions': ('clobber', 05:47:19 INFO - 'read-buildbot-config', 05:47:19 INFO - 'download-and-extract', 05:47:19 INFO - 'populate-webroot', 05:47:19 INFO - 'create-virtualenv', 05:47:19 INFO - 'install', 05:47:19 INFO - 'run-tests'), 05:47:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:19 INFO - 'download_minidump_stackwalk': True, 05:47:19 INFO - 'download_symbols': 'ondemand', 05:47:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:19 INFO - 'installer_path': 'installer.exe', 05:47:19 INFO - 'log_level': 'info', 05:47:19 INFO - 'log_name': 'talos', 05:47:19 INFO - 'log_to_console': True, 05:47:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:19 INFO - 'opt_config_files': (), 05:47:19 INFO - 'pip_index': False, 05:47:19 INFO - 'sps_profile': False, 05:47:19 INFO - 'sps_profile_interval': 0, 05:47:19 INFO - 'suite': 'dromaeojs', 05:47:19 INFO - 'system_bits': '32', 05:47:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:19 INFO - 'title': 'talos-linux64-ix-017', 05:47:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:19 INFO - 'use_talos_json': True, 05:47:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:19 INFO - 'work_dir': 'build'} 05:47:19 INFO - ##### 05:47:19 INFO - ##### Running clobber step. 05:47:19 INFO - ##### 05:47:19 INFO - Running pre-action listener: _resource_record_pre_action 05:47:19 INFO - Running main action method: clobber 05:47:19 INFO - rmtree: /builds/slave/test/build 05:47:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:20 INFO - Running post-action listener: _resource_record_post_action 05:47:20 INFO - ##### 05:47:20 INFO - ##### Finished clobber step (success) 05:47:20 INFO - ##### 05:47:20 INFO - ##### 05:47:20 INFO - ##### Running read-buildbot-config step. 05:47:20 INFO - ##### 05:47:20 INFO - Running pre-action listener: _resource_record_pre_action 05:47:20 INFO - Running main action method: read_buildbot_config 05:47:20 INFO - Using buildbot properties: 05:47:20 INFO - { 05:47:20 INFO - "project": "", 05:47:20 INFO - "product": "firefox", 05:47:20 INFO - "script_repo_revision": "production", 05:47:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:47:20 INFO - "repository": "", 05:47:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:47:20 INFO - "buildid": "20160527030220", 05:47:20 INFO - "stage_platform": "linux64-pgo", 05:47:20 INFO - "basedir": "/builds/slave/test", 05:47:20 INFO - "nightly_build": "True", 05:47:20 INFO - "buildnumber": 308, 05:47:20 INFO - "slavename": "talos-linux64-ix-017", 05:47:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:47:20 INFO - "platform": "ubuntu64_hw", 05:47:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:20 INFO - "branch": "mozilla-central", 05:47:20 INFO - "repo_path": "mozilla-central", 05:47:20 INFO - "revision": "4d63dde701b47b8661ab7990f197b6b60e543839", 05:47:20 INFO - "pgo_build": "True", 05:47:20 INFO - "builduid": "abfda7b12b6f40ce8231055758352076", 05:47:20 INFO - "slavebuilddir": "test" 05:47:20 INFO - } 05:47:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:47:20 INFO - Running post-action listener: _resource_record_post_action 05:47:20 INFO - ##### 05:47:20 INFO - ##### Finished read-buildbot-config step (success) 05:47:20 INFO - ##### 05:47:20 INFO - ##### 05:47:20 INFO - ##### Running download-and-extract step. 05:47:20 INFO - ##### 05:47:20 INFO - Running pre-action listener: _resource_record_pre_action 05:47:20 INFO - Running main action method: download_and_extract 05:47:20 INFO - mkdir: /builds/slave/test/build/tests 05:47: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:47:20 INFO - https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:21 INFO - Downloaded 1361 bytes. 05:47:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:21 INFO - Using the following test package requirements: 05:47:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'jsshell-linux-x86_64.zip'], 05:47:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:21 INFO - https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:22 INFO - Downloaded 24410403 bytes. 05:47:22 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:47:22 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:47:23 INFO - Return code: 0 05:47:23 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:47:23 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:47:23 INFO - https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:29 INFO - Downloaded 24410403 bytes. 05:47: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:47: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:47:31 INFO - Return code: 0 05:47:31 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:47:31 INFO - https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:33 INFO - Downloaded 10834034 bytes. 05:47:33 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:47:33 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:47:33 INFO - Return code: 0 05:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:33 INFO - https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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:47:36 INFO - Downloaded 58688042 bytes. 05:47:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:36 INFO - mkdir: /builds/slave/test/properties 05:47:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:36 INFO - Contents: 05:47:36 INFO - build_url:https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:37 INFO - Running post-action listener: _resource_record_post_action 05:47:37 INFO - Running post-action listener: set_extra_try_arguments 05:47:37 INFO - ##### 05:47:37 INFO - ##### Finished download-and-extract step (success) 05:47:37 INFO - ##### 05:47:37 INFO - ##### 05:47:37 INFO - ##### Running populate-webroot step. 05:47:37 INFO - ##### 05:47:37 INFO - Running pre-action listener: _resource_record_pre_action 05:47:37 INFO - Running main action method: populate_webroot 05:47:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:37 INFO - '--tppagecycles', 05:47:37 INFO - '7'], 05:47:37 INFO - 'tests': ['tsvgm']}}, 05:47:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['damp', 'tps']}, 05:47:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'tests': ['damp', 'tps']}, 05:47:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['dromaeo_dom']}, 05:47:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['a11yr', 05:47:37 INFO - 'ts_paint', 05:47:37 INFO - 'tpaint', 05:47:37 INFO - 'sessionrestore', 05:47:37 INFO - 'sessionrestore_no_auto_restore', 05:47:37 INFO - 'tabpaint']}, 05:47:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['tsvgx', 05:47:37 INFO - 'tsvgr_opacity', 05:47:37 INFO - 'tart', 05:47:37 INFO - 'tscrollx', 05:47:37 INFO - 'cart']}, 05:47:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:37 INFO - 'tsvgr_opacity', 05:47:37 INFO - 'tart', 05:47:37 INFO - 'tscrollx', 05:47:37 INFO - 'cart']}, 05:47:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'talos_options': ['--disable-e10s'], 05:47:37 INFO - 'tests': ['tp5o']}, 05:47:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'tests': ['tp5o']}, 05:47:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'talos_options': ['--disable-e10s', 05:47:37 INFO - '--xperf_path', 05:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:37 INFO - 'tests': ['tp5n']}, 05:47:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:37 INFO - 'talos_options': ['--xperf_path', 05:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:37 INFO - 'tests': ['tp5n']}}, 05:47:37 INFO - 'talos.zip': {'path': '', 05:47:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:37 INFO - Running post-action listener: _resource_record_post_action 05:47:37 INFO - ##### 05:47:37 INFO - ##### Finished populate-webroot step (success) 05:47:37 INFO - ##### 05:47:37 INFO - ##### 05:47:37 INFO - ##### Running create-virtualenv step. 05:47:37 INFO - ##### 05:47:37 INFO - Running pre-action listener: _resource_record_pre_action 05:47:37 INFO - Running main action method: create_virtualenv 05:47:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:47:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:37 INFO - Using real prefix '/usr' 05:47:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:40 INFO - Installing pip.................done. 05:47:40 INFO - Return code: 0 05:47:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:47:40 INFO - Using env: {'DISPLAY': ':0', 05:47:40 INFO - 'HOME': '/home/cltbld', 05:47:40 INFO - 'LANG': 'en_US.UTF-8', 05:47:40 INFO - 'LANGUAGE': 'en_US:en', 05:47:40 INFO - 'LOGNAME': 'cltbld', 05:47:40 INFO - 'MAIL': '/var/mail/cltbld', 05:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:40 INFO - 'MOZ_NO_REMOTE': '1', 05:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:40 INFO - 'NO_EM_RESTART': '1', 05:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:40 INFO - 'PWD': '/builds/slave/test', 05:47:40 INFO - 'SHELL': '/bin/bash', 05:47:40 INFO - 'SHLVL': '1', 05:47:40 INFO - 'TERM': 'linux', 05:47:40 INFO - 'TMOUT': '86400', 05:47:40 INFO - 'USER': 'cltbld', 05:47:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:40 INFO - '_': '/tools/buildbot/bin/python'} 05:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:47:40 INFO - Cleaning up... 05:47:40 INFO - Return code: 0 05:47:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:47:40 INFO - Using env: {'DISPLAY': ':0', 05:47:40 INFO - 'HOME': '/home/cltbld', 05:47:40 INFO - 'LANG': 'en_US.UTF-8', 05:47:40 INFO - 'LANGUAGE': 'en_US:en', 05:47:40 INFO - 'LOGNAME': 'cltbld', 05:47:40 INFO - 'MAIL': '/var/mail/cltbld', 05:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:40 INFO - 'MOZ_NO_REMOTE': '1', 05:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:40 INFO - 'NO_EM_RESTART': '1', 05:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:40 INFO - 'PWD': '/builds/slave/test', 05:47:40 INFO - 'SHELL': '/bin/bash', 05:47:40 INFO - 'SHLVL': '1', 05:47:40 INFO - 'TERM': 'linux', 05:47:40 INFO - 'TMOUT': '86400', 05:47:40 INFO - 'USER': 'cltbld', 05:47:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:40 INFO - '_': '/tools/buildbot/bin/python'} 05:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:40 INFO - Downloading/unpacking psutil>=3.1.1 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:42 INFO - Installing collected packages: psutil 05:47:42 INFO - Running setup.py install for psutil 05:47:42 INFO - building 'psutil._psutil_linux' extension 05:47:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:47:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:47:42 INFO - building 'psutil._psutil_posix' extension 05:47:42 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:47:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:47:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:43 INFO - Successfully installed psutil 05:47:43 INFO - Cleaning up... 05:47:43 INFO - Return code: 0 05:47:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:47:43 INFO - Using env: {'DISPLAY': ':0', 05:47:43 INFO - 'HOME': '/home/cltbld', 05:47:43 INFO - 'LANG': 'en_US.UTF-8', 05:47:43 INFO - 'LANGUAGE': 'en_US:en', 05:47:43 INFO - 'LOGNAME': 'cltbld', 05:47:43 INFO - 'MAIL': '/var/mail/cltbld', 05:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:43 INFO - 'MOZ_NO_REMOTE': '1', 05:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:43 INFO - 'NO_EM_RESTART': '1', 05:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:43 INFO - 'PWD': '/builds/slave/test', 05:47:43 INFO - 'SHELL': '/bin/bash', 05:47:43 INFO - 'SHLVL': '1', 05:47:43 INFO - 'TERM': 'linux', 05:47:43 INFO - 'TMOUT': '86400', 05:47:43 INFO - 'USER': 'cltbld', 05:47:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:43 INFO - '_': '/tools/buildbot/bin/python'} 05:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:45 INFO - Installing collected packages: mozsystemmonitor 05:47:45 INFO - Running setup.py install for mozsystemmonitor 05:47:45 INFO - Successfully installed mozsystemmonitor 05:47:45 INFO - Cleaning up... 05:47:45 INFO - Return code: 0 05:47:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:47:45 INFO - Using env: {'DISPLAY': ':0', 05:47:45 INFO - 'HOME': '/home/cltbld', 05:47:45 INFO - 'LANG': 'en_US.UTF-8', 05:47:45 INFO - 'LANGUAGE': 'en_US:en', 05:47:45 INFO - 'LOGNAME': 'cltbld', 05:47:45 INFO - 'MAIL': '/var/mail/cltbld', 05:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:45 INFO - 'MOZ_NO_REMOTE': '1', 05:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:45 INFO - 'NO_EM_RESTART': '1', 05:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:45 INFO - 'PWD': '/builds/slave/test', 05:47:45 INFO - 'SHELL': '/bin/bash', 05:47:45 INFO - 'SHLVL': '1', 05:47:45 INFO - 'TERM': 'linux', 05:47:45 INFO - 'TMOUT': '86400', 05:47:45 INFO - 'USER': 'cltbld', 05:47:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:45 INFO - '_': '/tools/buildbot/bin/python'} 05:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:48 INFO - Downloading docopt-0.6.1.tar.gz 05:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:48 INFO - Running setup.py install for blobuploader 05:47:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:48 INFO - Running setup.py install for requests 05:47:48 INFO - Running setup.py install for docopt 05:47:48 INFO - Successfully installed blobuploader requests docopt 05:47:48 INFO - Cleaning up... 05:47:48 INFO - Return code: 0 05:47:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47: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:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:48 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 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:48 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:47:48 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:47:48 INFO - Using env: {'DISPLAY': ':0', 05:47:48 INFO - 'HOME': '/home/cltbld', 05:47:48 INFO - 'LANG': 'en_US.UTF-8', 05:47:48 INFO - 'LANGUAGE': 'en_US:en', 05:47:48 INFO - 'LOGNAME': 'cltbld', 05:47:48 INFO - 'MAIL': '/var/mail/cltbld', 05:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:48 INFO - 'MOZ_NO_REMOTE': '1', 05:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:48 INFO - 'NO_EM_RESTART': '1', 05:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:48 INFO - 'PWD': '/builds/slave/test', 05:47:48 INFO - 'SHELL': '/bin/bash', 05:47:48 INFO - 'SHLVL': '1', 05:47:48 INFO - 'TERM': 'linux', 05:47:48 INFO - 'TMOUT': '86400', 05:47:48 INFO - 'USER': 'cltbld', 05:47:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:48 INFO - '_': '/tools/buildbot/bin/python'} 05:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:49 INFO - Running setup.py (path:/tmp/pip-Uadx8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:49 INFO - Running setup.py (path:/tmp/pip-Nk_Sim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:49 INFO - Running setup.py (path:/tmp/pip-VHPzH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:49 INFO - Running setup.py (path:/tmp/pip-UZtsH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:49 INFO - Running setup.py (path:/tmp/pip-YP50Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:49 INFO - Running setup.py (path:/tmp/pip-n3DYUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:49 INFO - Running setup.py (path:/tmp/pip-UOfZbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:49 INFO - Running setup.py (path:/tmp/pip-EN_5W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:49 INFO - Running setup.py (path:/tmp/pip-_DZS2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:49 INFO - Running setup.py (path:/tmp/pip-mzSMnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:49 INFO - Running setup.py (path:/tmp/pip-lyGSSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:49 INFO - Running setup.py (path:/tmp/pip-Mkgiaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:49 INFO - Running setup.py (path:/tmp/pip-r3dpmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:49 INFO - Running setup.py (path:/tmp/pip-u4244x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:50 INFO - Running setup.py (path:/tmp/pip-EhuwQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:50 INFO - Running setup.py (path:/tmp/pip-wgiMot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:50 INFO - Running setup.py (path:/tmp/pip-vKCcsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:50 INFO - Running setup.py install for manifestparser 05:47:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:50 INFO - Running setup.py install for mozcrash 05:47:50 INFO - Running setup.py install for mozdebug 05:47:50 INFO - Running setup.py install for mozdevice 05:47:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:50 INFO - Running setup.py install for mozfile 05:47:50 INFO - Running setup.py install for mozhttpd 05:47:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:50 INFO - Running setup.py install for mozinfo 05:47:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:50 INFO - Running setup.py install for mozInstall 05:47:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Running setup.py install for mozleak 05:47:51 INFO - Running setup.py install for mozlog 05:47:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Running setup.py install for moznetwork 05:47:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Running setup.py install for mozprocess 05:47:51 INFO - Running setup.py install for mozprofile 05:47:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Running setup.py install for mozrunner 05:47:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:51 INFO - Running setup.py install for mozscreenshot 05:47:51 INFO - Running setup.py install for moztest 05:47:51 INFO - Running setup.py install for mozversion 05:47:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:52 INFO - Cleaning up... 05:47:52 INFO - Return code: 0 05:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:47:52 INFO - Using env: {'DISPLAY': ':0', 05:47:52 INFO - 'HOME': '/home/cltbld', 05:47:52 INFO - 'LANG': 'en_US.UTF-8', 05:47:52 INFO - 'LANGUAGE': 'en_US:en', 05:47:52 INFO - 'LOGNAME': 'cltbld', 05:47:52 INFO - 'MAIL': '/var/mail/cltbld', 05:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:52 INFO - 'MOZ_NO_REMOTE': '1', 05:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:52 INFO - 'NO_EM_RESTART': '1', 05:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:52 INFO - 'PWD': '/builds/slave/test', 05:47:52 INFO - 'SHELL': '/bin/bash', 05:47:52 INFO - 'SHLVL': '1', 05:47:52 INFO - 'TERM': 'linux', 05:47:52 INFO - 'TMOUT': '86400', 05:47:52 INFO - 'USER': 'cltbld', 05:47:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:52 INFO - '_': '/tools/buildbot/bin/python'} 05:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:52 INFO - Running setup.py (path:/tmp/pip-fzYpUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:52 INFO - Running setup.py (path:/tmp/pip-m9U9Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:52 INFO - Running setup.py (path:/tmp/pip-KVsBdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:52 INFO - Running setup.py (path:/tmp/pip-0_oYHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:52 INFO - Running setup.py (path:/tmp/pip-gUq8cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:52 INFO - Running setup.py (path:/tmp/pip-A4jCU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:52 INFO - Running setup.py (path:/tmp/pip-JhBfyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:52 INFO - Running setup.py (path:/tmp/pip-zAAKMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:52 INFO - Running setup.py (path:/tmp/pip-odiwWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:52 INFO - Running setup.py (path:/tmp/pip-yC0pph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:52 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:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:52 INFO - Running setup.py (path:/tmp/pip-uBWkLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:53 INFO - Running setup.py (path:/tmp/pip-IpXUww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:53 INFO - Running setup.py (path:/tmp/pip-jfKkIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:53 INFO - Running setup.py (path:/tmp/pip-3iZXZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:53 INFO - Running setup.py (path:/tmp/pip-iI7NXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:53 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:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:53 INFO - Running setup.py (path:/tmp/pip-1VjKpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:53 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:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:53 INFO - Running setup.py (path:/tmp/pip-8Q32Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:55 INFO - Downloading blessings-1.6.tar.gz 05:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:55 INFO - Installing collected packages: blessings 05:47:55 INFO - Running setup.py install for blessings 05:47:55 INFO - Successfully installed blessings 05:47:55 INFO - Cleaning up... 05:47:55 INFO - Return code: 0 05:47:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:55 INFO - Reading from file tmpfile_stdout 05:47:55 INFO - Current package versions: 05:47:55 INFO - argparse == 1.2.1 05:47:55 INFO - blessings == 1.6 05:47:55 INFO - blobuploader == 1.2.4 05:47:55 INFO - docopt == 0.6.1 05:47:55 INFO - manifestparser == 1.1 05:47:55 INFO - mozInstall == 1.12 05:47:55 INFO - mozcrash == 0.17 05:47:55 INFO - mozdebug == 0.1 05:47:55 INFO - mozdevice == 0.48 05:47:55 INFO - mozfile == 1.2 05:47:55 INFO - mozhttpd == 0.7 05:47:55 INFO - mozinfo == 0.9 05:47:55 INFO - mozleak == 0.1 05:47:55 INFO - mozlog == 3.2 05:47:55 INFO - moznetwork == 0.27 05:47:55 INFO - mozprocess == 0.22 05:47:55 INFO - mozprofile == 0.28 05:47:55 INFO - mozrunner == 6.11 05:47:55 INFO - mozscreenshot == 0.1 05:47:55 INFO - mozsystemmonitor == 0.3 05:47:55 INFO - moztest == 0.7 05:47:55 INFO - mozversion == 1.4 05:47:55 INFO - psutil == 3.1.1 05:47:55 INFO - requests == 1.2.3 05:47:55 INFO - wsgiref == 0.1.2 05:47:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:55 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 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:55 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:47:55 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:47:55 INFO - Using env: {'DISPLAY': ':0', 05:47:55 INFO - 'HOME': '/home/cltbld', 05:47:55 INFO - 'LANG': 'en_US.UTF-8', 05:47:55 INFO - 'LANGUAGE': 'en_US:en', 05:47:55 INFO - 'LOGNAME': 'cltbld', 05:47:55 INFO - 'MAIL': '/var/mail/cltbld', 05:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:55 INFO - 'MOZ_NO_REMOTE': '1', 05:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:55 INFO - 'NO_EM_RESTART': '1', 05:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:55 INFO - 'PWD': '/builds/slave/test', 05:47:55 INFO - 'SHELL': '/bin/bash', 05:47:55 INFO - 'SHLVL': '1', 05:47:55 INFO - 'TERM': 'linux', 05:47:55 INFO - 'TMOUT': '86400', 05:47:55 INFO - 'USER': 'cltbld', 05:47:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:55 INFO - '_': '/tools/buildbot/bin/python'} 05:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:47:56 INFO - Cleaning up... 05:47:56 INFO - Return code: 0 05:47:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47: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:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:47:56 INFO - Using env: {'DISPLAY': ':0', 05:47:56 INFO - 'HOME': '/home/cltbld', 05:47:56 INFO - 'LANG': 'en_US.UTF-8', 05:47:56 INFO - 'LANGUAGE': 'en_US:en', 05:47:56 INFO - 'LOGNAME': 'cltbld', 05:47:56 INFO - 'MAIL': '/var/mail/cltbld', 05:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:56 INFO - 'MOZ_NO_REMOTE': '1', 05:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:56 INFO - 'NO_EM_RESTART': '1', 05:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:56 INFO - 'PWD': '/builds/slave/test', 05:47:56 INFO - 'SHELL': '/bin/bash', 05:47:56 INFO - 'SHLVL': '1', 05:47:56 INFO - 'TERM': 'linux', 05:47:56 INFO - 'TMOUT': '86400', 05:47:56 INFO - 'USER': 'cltbld', 05:47:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:56 INFO - '_': '/tools/buildbot/bin/python'} 05:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:56 INFO - Downloading/unpacking jsonschema 05:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:58 INFO - warning: no files found matching '*.txt' 05:47:58 INFO - no previously-included directories found matching 'build' 05:47:58 INFO - no previously-included directories found matching 'dist' 05:47:58 INFO - no previously-included directories found matching '.git*' 05:47:58 INFO - Installing collected packages: jsonschema, functools32 05:47:58 INFO - Running setup.py install for functools32 05:47:58 INFO - warning: no files found matching '*.txt' 05:47:58 INFO - no previously-included directories found matching 'build' 05:47:58 INFO - no previously-included directories found matching 'dist' 05:47:58 INFO - no previously-included directories found matching '.git*' 05:47:58 INFO - Successfully installed jsonschema functools32 05:47:58 INFO - Cleaning up... 05:47:58 INFO - Return code: 0 05:47:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:47:58 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:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 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:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 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 0x7f8b2e893f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, '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': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', '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:47:58 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:47:58 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:47:58 INFO - Using env: {'DISPLAY': ':0', 05:47:58 INFO - 'HOME': '/home/cltbld', 05:47:58 INFO - 'LANG': 'en_US.UTF-8', 05:47:58 INFO - 'LANGUAGE': 'en_US:en', 05:47:58 INFO - 'LOGNAME': 'cltbld', 05:47:58 INFO - 'MAIL': '/var/mail/cltbld', 05:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:58 INFO - 'MOZ_NO_REMOTE': '1', 05:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:58 INFO - 'NO_EM_RESTART': '1', 05:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:58 INFO - 'PWD': '/builds/slave/test', 05:47:58 INFO - 'SHELL': '/bin/bash', 05:47:58 INFO - 'SHLVL': '1', 05:47:58 INFO - 'TERM': 'linux', 05:47:58 INFO - 'TMOUT': '86400', 05:47:58 INFO - 'USER': 'cltbld', 05:47:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:58 INFO - '_': '/tools/buildbot/bin/python'} 05:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:58 INFO - Downloading/unpacking flake8 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48:00 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:48:00 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:48:00 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:48:00 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:48:00 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:48:00 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:48:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48:00 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:48:00 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:48:00 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:48:00 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:48:00 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:48:00 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:48:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48: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:48: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:48: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:48: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:48: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:48: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:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:01 INFO - no previously-included directories found matching 'docs/_build' 05:48:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:01 INFO - Running setup.py install for pep8 05:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:01 INFO - no previously-included directories found matching 'docs/_build' 05:48:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:48:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:01 INFO - Cleaning up... 05:48:01 INFO - Return code: 0 05:48:01 INFO - Running post-action listener: _resource_record_post_action 05:48:01 INFO - Running post-action listener: _start_resource_monitoring 05:48:01 INFO - Starting resource monitoring. 05:48:01 INFO - ##### 05:48:01 INFO - ##### Finished create-virtualenv step (success) 05:48:01 INFO - ##### 05:48:01 INFO - ##### 05:48:01 INFO - ##### Running install step. 05:48:01 INFO - ##### 05:48:01 INFO - Running pre-action listener: _resource_record_pre_action 05:48:01 INFO - Running main action method: install 05:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:01 INFO - Reading from file tmpfile_stdout 05:48:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:01 INFO - Reading from file tmpfile_stdout 05:48:01 INFO - Output received: 05:48:01 INFO - Usage: mozinstall [options] installer 05:48:01 INFO - Options: 05:48:01 INFO - -h, --help show this help message and exit 05:48:01 INFO - -d DEST, --destination=DEST 05:48:01 INFO - Directory to install application into. [default: 05:48:01 INFO - "/builds/slave/test"] 05:48:01 INFO - --app=APP Application being installed. [default: firefox] 05:48:01 INFO - mkdir: /builds/slave/test/build/application 05:48:01 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:48:01 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:48:18 INFO - Reading from file tmpfile_stdout 05:48:18 INFO - Output received: 05:48:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:18 INFO - Running post-action listener: _resource_record_post_action 05:48:18 INFO - ##### 05:48:18 INFO - ##### Finished install step (success) 05:48:18 INFO - ##### 05:48:18 INFO - ##### 05:48:18 INFO - ##### Running run-tests step. 05:48:18 INFO - ##### 05:48:18 INFO - Running pre-action listener: _resource_record_pre_action 05:48:18 INFO - Running main action method: run_tests 05:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:18 INFO - Python 2.7.3 05:48:18 INFO - Return code: 0 05:48:18 INFO - grabbing minidump binary from tooltool 05:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:18 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 0x293c9c0>, '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 0x293d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:18 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:48:18 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:48:18 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:48:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:18 INFO - Return code: 0 05:48:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:48:19 INFO - Return code: 0 05:48:19 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/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:48:19 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/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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:48:19 INFO - Using env: {'DISPLAY': ':0', 05:48:19 INFO - 'HOME': '/home/cltbld', 05:48:19 INFO - 'LANG': 'en_US.UTF-8', 05:48:19 INFO - 'LANGUAGE': 'en_US:en', 05:48:19 INFO - 'LOGNAME': 'cltbld', 05:48:19 INFO - 'MAIL': '/var/mail/cltbld', 05:48:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:19 INFO - 'MOZ_NO_REMOTE': '1', 05:48:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:19 INFO - 'NO_EM_RESTART': '1', 05:48:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:19 INFO - 'PWD': '/builds/slave/test', 05:48:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:19 INFO - 'SHELL': '/bin/bash', 05:48:19 INFO - 'SHLVL': '1', 05:48:19 INFO - 'TERM': 'linux', 05:48:19 INFO - 'TMOUT': '86400', 05:48:19 INFO - 'USER': 'cltbld', 05:48:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707', 05:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:19 INFO - '_': '/tools/buildbot/bin/python'} 05:48:19 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/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:48:19 INFO - mozversion application_buildid: 20160527030220 05:48:19 INFO - mozversion application_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 05:48:19 INFO - mozversion application_display_name: Nightly 05:48:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:19 INFO - mozversion application_name: Firefox 05:48:19 INFO - mozversion application_remotingname: firefox 05:48:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:19 INFO - mozversion application_vendor: Mozilla 05:48:19 INFO - mozversion application_version: 49.0a1 05:48:19 INFO - mozversion platform_buildid: 20160527030220 05:48:19 INFO - mozversion platform_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 05:48:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:19 INFO - mozversion platform_version: 49.0a1 05:48:19 INFO - using testdate: 1464353299 05:48:19 INFO - actual date: 1464353299 05:48:19 INFO - starting webserver on 'localhost:60200' 05:48:19 INFO - SUITE-START | Running 2 tests 05:48:19 INFO - TEST-START | dromaeo_css 05:48:19 INFO - operating with platform_type : linux_ 05:48:19 INFO - Initialising browser for dromaeo_css test... 05:48:19 INFO - TEST-INFO | started process 30221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9hiL9/profile http://localhost:60200/getInfo.html) 05:48:23 INFO - PROCESS | 30221 | __metrics Screen width/height:1600/1200 05:48:23 INFO - PROCESS | 30221 | colorDepth:24 05:48:23 INFO - PROCESS | 30221 | Browser inner width/height: 1024/697 05:48:23 INFO - PROCESS | 30221 | __metrics 05:48:24 ERROR - PROCESS | 30221 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:48:25 INFO - TEST-INFO | 30221: exit 0 05:48:25 INFO - Browser initialized. 05:48:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:25 INFO - TEST-INFO | started process 30303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9hiL9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:37 INFO - PROCESS | 30303 | RSS: Main: 155160576 05:48:37 INFO - PROCESS | 30303 | 05:49:28 INFO - PROCESS | 30303 | 1464353368014 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:51:35 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60200/tests/dromaeo/cssquery-ext.html) 05:51:36 INFO - PROCESS | 30303 | RSS: Main: 292835328 05:51:36 INFO - PROCESS | 30303 | 05:54:39 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-ext.html (next: http://localhost:60200/tests/dromaeo/cssquery-jquery.html) 05:54:39 INFO - PROCESS | 30303 | RSS: Main: 235847680 05:54:39 INFO - PROCESS | 30303 | 05:57:41 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60200/tests/dromaeo/cssquery-mootools.html) 05:57:42 INFO - PROCESS | 30303 | RSS: Main: 239263744 05:57:42 INFO - PROCESS | 30303 | 06:00:44 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60200/tests/dromaeo/cssquery-prototype.html) 06:00:45 INFO - PROCESS | 30303 | RSS: Main: 236498944 06:00:45 INFO - PROCESS | 30303 | 06:03:47 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60200/tests/dromaeo/cssquery-yui.html) 06:03:48 INFO - PROCESS | 30303 | RSS: Main: 226136064 06:03:48 INFO - PROCESS | 30303 | 06:06:50 INFO - PROCESS | 30303 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-yui.html (next: http://localhost:60200/tests/dromaeo/cssquery-dojo.html) 06:06:51 INFO - PROCESS | 30303 | RSS: Main: 274550784 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | __start_tp_report 06:06:51 INFO - PROCESS | 30303 | _x_x_mozilla_page_load 06:06:51 INFO - PROCESS | 30303 | _x_x_mozilla_page_load_details 06:06:51 INFO - PROCESS | 30303 | |i|pagename|runs| 06:06:51 INFO - PROCESS | 30303 | |0;dojo.html;3102.627684677838;3105.037438394098;3123.312871168342;3124.6250449946;3168.841557922103;5174.43081261061;5264.078786212417;5277.551408130309;5371.973140134299;5399.217113518537;5267.051930652481;5303.946960530394;5349.732513374335;5357.276767636377;5372.167314066326;4581.79381927814;4796.544328288815;4903.2645103234445;4906.9263961040615;4927.2609108633815;4713.622910167179;4883.9511604883855;4904.730239836807;4923.950760492385;4932.482089380617;4760.262159365287;4762.3094651275715;4783.976080119612;4905.8773530661665;4916.827911023132;4751.4535828379485;4754.477007529169;4765.499622539618;4810.326554282403;4854.344663470457;4763.452202996665;4791.448983366922;4796.160671882441;4809.807607695688;4854.101991131617;5102.974485127587;5171.534561889411;5246.685198888041;5336.813211537617;5343.65266257692;5737.454941780524;5787.884242315172;5790.594658373915;5794.5074668653215;5796.710164491801;5570.2480165177585;5801;5823.82528524145;5824.126381042835;5832.066869300934;5305.151175811851;5374.7043912584795;5393.649412788156;5448.891022179574;5456.91814622781;5989.55078369124;6003.309619393825;6004.099385092184;6005.669688167192;6006.018014055351;5436.374816896107;5492.286002819608;5739.65562066269;5747.511461525817;5750.396208398141;5617.634853734494;5680.261565996477;5729.4843464088435;5740.512056475163;5740.885182296331;5610.298712660918;5612.242347283146;5616.550675945996;5618.550515958714;5627.240322556402;5494.945050549443;5575.8884822304135;5630;5631.746571404296;5637.295338082739;4302.333138363559;4324.610785029363;4358.956410435919;4362.192994296065;4370.54109318517;3880.8059597020037;3882.8058597070035;3891.3384724596885;3926.960730392717;3930.1746633206776;5219.42586315505;5455.481729235717;5463.289772329572;5465.180222966507;5467.234587157801;5672.262605861294;5727.627704199213;5737.799177028784;5749.655020698688;5771.076627739541;5444.618876678674;5451.509364157166;5454.4545545445935;5460.262864513319;5461.344638643388;4695.413073365829;4730.195866702668;4831.51684831514;4839.612830973514;4886.584640305543;5837.708114594253;5882.9116613425795;5897.410258974069;5899.469047785634;5944.791932282349;5711.971440142773;5713.057345538023;5717.256756621613;5718;5718.914216286842;5749.655020698771;5804.6807425592;5846.298444186725;5847.649141051551;5865.765369385347;5632.662040277596;5646.463585959327;5652.180433836988;5653.830385088454;5694.544436444991;5623.606347555796;5715.94255062798;5719.828405147852;5720.8283751487525;5734.655920644775;5452.727363631882;5569.972150139223;5576.888462230651;5624.409437009055;5659.886802264014;5607.915881261866;5612.8877422450505;5625.371635295293;5630.18362337467;5640.210370548045;5550.861228469321;5553.389127196086;5558.555315574664;5559.082751345983;5562.415946325739;5419.2954915862265;5460.126379779216;5563.05428077236;5641.971790141023;5647.943520564741;5432.511074003359;5469.2616496772425;5486.835394938158;5494.340679118532;5572.024895643327 06:06:51 INFO - PROCESS | 30303 | |1;ext.html;585.7159277750293;614.741808440455;618.2611778924185;636.8789929913313;649.2890285137775;31128.377432451336;31660.683393166062;33873.1531711707;33913.49129763049;43252;41878.371824422655;46698.76650616742;46703;46714.299285510744;46737.29894051592;8806.251468625174;9021.413608115452;9029.909700903005;9029.909700903005;9033.548322583878;8850.247728943015;8983.55082245885;8984.595693193789;8992.05583413742;9003.594838232262;9005.279577633773;9072.047435019327;9078.909210907905;9081.727548173532;9086.681966131187;8950.418222815497;8988.550572471415;9015.008349081629;9017.323700722407;9019.503927283997;8837.204651581324;8928.419652722552;8941;8942.374033817636;8943.865842012376;43492.3476147858;43898.34152487715;43926.560734392886;43959;43987.34018989686;3504.5268888700207;3628.32875917956;3682.042668906077;3689.4465830125428;4084.2239974405065;32358;32749.67250327514;33027.504587431205;33435.16412089693;34307.62769489217;4399.494058183286;4446.510883802779;4488.887777805581;4492.977535112336;4510.954890451087;323913;324484;324854.9999999976;325014;325747;54038.72980635072;58280;59456.10815837766;59869;59956.40043599595;60377.69811151004;64617;65148;65192;65247;16854.07302598344;17144.314227431012;17188.31246750116;17188.398406055727;17195.828041719422;12194.878051219552;12726.745465090646;12740.808887866504;12912.289824059579;12963.351832408342;18434.170462329228;18567.535811604546;18697.065146742607;18710.71933920992;18733.906330468533;5967.522598192134;5998.760049597967;6059.394060593905;6067.787627433018;6293.968530157412;925.5233554719325;992.5509250792221;1099.7910397024539;1103.8840921703265;1190.7082764722525;32272.031839044867;32632.83683581567;32995.340093198;33076.503852441754;33169.66884056903;1104.2987702808775;1107.6123356825046;1160.721426857565;1227.8035514317844;1244.5333000124954;17233.39683111085;17270.654586908193;17444.47666570005;17446.738298925527;17640.735388969177;491632;494280;495141;495392;499343;58256.12615810766;58493;58538.7073064632;58616.706916466;58721.70639146777;1247.544646204147;1341.8591047939826;1352.8444228913604;1356.4438580182077;1401.474447082344;31807.522887157174;32975.34049319048;33299.50050749289;33423.49864752079;33855.15362115967;50615.49384506255;50893.74553127211;51198;51202.23196652128;51206.74396627993;313769;313874;313910;315310;315445;36835;37763.81118094392;43039.354409683256;44480.555194448934;46946.53053469422;47796;48824.511754882;48971;49278.507214928824;49345.50654493409;40242.59757402506;40998.59001410067;41386.79306603448;41612.58387416208;41950.37074443947;40587.59412405838;40642.59357406506;40796.592034080466;41352.1729565401;41970;40700;41090.89091090867;41498.37752433655;41564.58435415607;41948.37077443902;36654.450183246736;37076;37490.62509374871;37797.811010944766;37943.2411351777;28040.71959280381;28149.57775633408;28244.576331354634;28413.857930710215;28653.841380166316 06:06:51 INFO - PROCESS | 30303 | |2;jquery.html;383.0041891083183;388.07392262341943;389.85575337125266;395.5352460858492;418.09482470451474;14468.276586170701;16149.515514534552;18088.90955545222;19559.902200488996;19578.902105489487;14115.858841411582;17053.48839534816;17098;17535.5616109597;18556.07219639016;5525.668459892419;5543.667379957205;5721.399253078429;5815.273090863642;5818.5345172386105;4059.3099173140636;5694.800681976131;5734.770609175628;5793.304803423595;6129.325774164839;6403.423691867731;6511;6524.0540121682325;6538.1827271591055;6539.149910511651;6259.37406259375;6452.0967064610995;6489.772857949973;6541.705623246965;6549.836254093662;5556.805511807108;5600.971995140039;5608.130739735348;5609.52319052881;5614.63504872182;21487.35537933849;21833.563328733497;22212.88893555522;22519.662205066936;22571;2346;2384.4396566806786;2516.773490385874;2528.734482879308;2564.435824118691;13798.517051903236;13893.861061389358;13902.443902243898;14181.85818141826;14807.111573305636;1869.9906500467546;1872.953176170593;1897.724829899657;1921.327535362626;1964.4204959536971;75201.62399188023;76894.61552692257;77427;78439.60780196119;79353.20646793516;10500.212484063726;10581.153507719364;10674.839877401846;10756.19328550362;10827.891721082846;14460.85539144616;14565.344559494848;14635.268236588341;14636.634084147769;14642.85357146415;7231.2768723127265;7832.725854595062;8080.313173380211;8228.588570571448;8371.790705232417;7984.920150798418;7996.600169991593;8084.434089613671;8195.877061844078;8217.671293148207;6524.380183882524;6605.30644282353;6653.933460665428;6656.933430665728;6658.9001164982565;1905.361703829205;1931.9323823666105;1938.5928954919625;1946.8734532255357;1985.7802170387927;909.3952521573212;988.614440368257;988.8615593816728;1043.1446214104512;1113.9665810025713;17525.824741752418;18810.52973675669;19051.809481905282;19930.800691993183;20208;957.3681370295571;1009.9091081802673;1018.2973748113777;1041.739565108723;1060.5439660945713;10462.947685261524;10586.100181484506;10594.735131621617;10660.081185386549;10679.252452328417;471098;482564;484887;486293;488995;94787.52606237063;97108.51445742726;97672;97877.51061244648;98057;1035.2804800663466;1055.9736006599896;1065.1212749481708;1066.6053560182781;1067.1782727299935;16669.083200424095;16764.1617919106;17037.233324500674;17159.914200428917;17336.913315433343;41201;42472;42832.78583607062;42999.355009675506;44334.778326108164;53964;55685;62402.68798655977;63152;63463.365366345744;8321.167883211872;8341.582920854054;8455.873161902453;8516.659333626585;8596.656133754579;12886.226826390446;12985.155964862253;13080.411381488046;13192.076554641082;13553.525626603021;11643.825342619699;11868.40657967081;11881.346525941157;11891.821622675494;12076.396180191132;10928.781424371628;11447.427628618703;11490.48292826808;11506.654800356002;11598.130140239684;11795.823062653895;12029.338386388832;12034.097442691658;12154.453049612965;12290.815637765261;8408.621612027597;8464.915350846659;8486.19381158789;8487.321014318963;8566.18621230982;10392.168626510012;11561.248518846249;11654.592089276835;12029.699257518632;12092 06:06:51 INFO - PROCESS | 30303 | |3;mootools.html;1383.9238841863694;1533.2333833083458;1549.7055559443704;1731.844134027938;1869.23361421817;8475.364347673925;8880.156385143417;8891.02198758137;9089.272858171347;9090.136437038487;8874.645014199425;9057.547122643875;9057.592408341625;9074.137956894101;9086.454812711241;1952.0142328124277;2223.466368071667;2261.42333704905;2279.931602051941;2289.7023386959672;2263.909443622253;2277.7836105569945;2277.8633282003134;2278.8632682039047;2284.8400611957168;2263.2757517594378;2269.0810221860174;2269.50070984384;2285.5086156476355;2287.805536529397;1913.2251438167564;1974.220183027696;2110.6728457089175;2170.0343347210496;2179.8583092099043;2206.5145667953025;2229.7547269800307;2230;2231.654093615492;2235.1953296813135;8353.540555269457;8380.329573634095;8392.454490458162;8394.202550757669;8397.874031889527;4896.779644915988;4970.080535100982;4990.675606085593;4999.925001124986;5007.524285192901;3166.857491412869;3249.545063691085;3352.379809735207;3384.120128766514;3401.9659803401896;1031.0771859186061;1052.6631477927067;1076.2735153771252;1086.3536195963388;1088.3089238333637;11486.253393529478;11557.884421155764;11570.59502917394;11594.246373985665;11681.649550513499;4399.802008909607;4431.313146462304;4476.149531588988;4534.79593418297;4541.591256786905;9963.701088967342;9967.900320996698;9974.20206383502;9989.100980911753;10000.649977250761;5001;5030.572401345927;5035.874103147377;5038;5039.974800125976;4115.794210289533;4434.379186913835;4545.931811022837;4549.954500455019;4590.563896429834;3841;3912.5304963404574;3951.5060617422823;3983.50206224222;4043.130726893732;1197.1500234833366;1198.370855300974;1211.1158854036603;1224.1002862895764;1225.4669218889812;781.8201813582908;942.4863449419945;956.0917128727737;957.8515330123842;969.6896992962326;6023.0619477861;6025.698715064229;6090.604110732788;6138.447539721446;6159.137720719103;435.7646870689792;438.6841474138615;438.7038748844517;441.7813182474696;445.274203049028;4106.589341065929;4195.160967806451;4204.2432362175105;4211.284081706117;4224.091820258598;10663.360198388122;10912.181586381053;11029.779404411867;11040.171987101;11061.944690276498;10862.076723478593;10892.292001019909;10936.781264374667;10959.232853700165;10988.835167472495;7822.374210063182;8194.631241594143;8198.467099638623;8201.056878459054;8301.418900676894;5900.173975643327;5959.463648271676;5997.430244126976;6050.30421501533;6069.635821850703;9489.857652135086;9544.761380965254;9545.379550329206;9581.041895810364;9582;9718.854217186607;9988.550515226978;10030.64892728751;10112.393256404639;10164.745881353025;6925;7724.575148366894;7948;7951.602419879098;8094.635741391534;8896.332775042027;8906.421082629608;8936.41913275635;8937.776555586162;8956.104389561253;7321.670524826289;7364.226756190523;7368.889466657897;7728.652210650422;8005.919940800751;7186.173590037003;7205.279472052753;7274.927250727425;7373.446991475768;7451.664675089743;6938.167419909643;6959;6962.303769622998;6973.232944376013;6985.685644145924;4702.130105930414;4759.42886853566;4794.137055329935;4911.214205727067;4940.283658869515;4840.854774356775;4862.17343051675;4862.489438608895;4933.753312334297;4938.30863679078 06:06:51 INFO - PROCESS | 30303 | |4;prototype.html;305.7385935025553;319.7665704036055;320.65209247965953;332.6307798343838;333.5397151930336;5212.400573933999;5254.211868219769;5274.736263186845;5332.360116785986;5341.706206158665;5150.407703114143;5220.903610241854;5228.4771522847695;5230.770768869313;5249.291345668334;4070.7177239169714;4089.488813898255;4131.7934103294865;4135.296999510076;4146;4055.5336136344404;4097.995990982198;4132.6775431861815;4145.233131870598;4149.2531344358;4108.8972775680695;4115.917681646365;4117.979410102946;4118.732282401635;4118.8673114893345;4099.549049604541;4103.651189648884;4105.137921036586;4124.216398884218;4126.917461650765;3618.5115009473648;3650.233450975298;3655.141041855162;3690.2619476104887;3697.630236976308;4844.491328410501;5010.273510341017;5020.824271150492;5054.418741844698;5149.918517111411;4633.907321853578;4664.207084795593;4686.172392766824;4690.78039709678;4703.717776933395;5410.594205434569;5426.484483974055;5431.429699881495;5466.289382380265;5497.917531237034;3673.3755261605324;3877.6122387760997;3888.319544079803;3909.374500080002;3953.1105501262273;5332.253484512172;5515.944840551623;5672.234248376458;5674.120511320752;5684.8010319638615;3957.782321972319;3960.6435420812263;3961.3661814110183;3966.7619942803526;3970.8808735737975;3776.6034566370686;3989.162275922031;4055;4089.631933126033;4104.56902025289;4601.4248218972625;4650.674452788272;4654.743989080565;4691.366665500113;4703.858884233478;5425.565954723692;5491.148871924858;5502.0921547944945;5515.393306736256;5548.55611551075;1411.3578321863527;1424.173979092124;1454.345544504977;1456.4538298138198;1456.730504856605;939.3143005605809;940.9952950235205;950.9001554836642;958.1903291718487;962.7015625156224;4714.45783734868;4735.337052812609;4771.403574553181;4791.496892826203;4858.65989380747;5003.649744517848;5008.5993120550265;5020.949790502048;5025.74871256443;5036.697798132123;4439.400680908101;4756.500567440438;4773.284007398918;4790.377250957423;4819;2667.6928305130346;2670.452557225764;2670.7298796023615;2671.879765410561;2683.5974603809195;5103.97448012765;5160.92258616121;5164.664296820694;5175.689458632494;5186.49591618434;5076.289319495274;5122.538971492583;5130.640855140179;5374.758135883894;5872.412758724179;5863;5935.169076329317;5963.642181469126;5974.446643872624;5974.761009559656;5444.183372494158;5679.34687510925;5680.869673872298;5707.08686610157;5737.885242295214;5237.528622424;5556.361018482926;5597.776088956396;5606.747696353592;5619.634723742944;5807.651540907559;5817.272840894888;5839;5893.793717219876;5902.498287645427;3938.2123575284486;3997.5202975641946;4009.2382447334912;4030.717849750489;4063.817128229296;5566.749496272597;5606.084835885398;5639.774409023593;5646.181303710857;5685.749135190252;5458.590605704509;5484.436935473371;5517.089680202722;5517.337919449692;5544.750486228048;5268.9736551317;5514.228008078792;5518.944810552004;5532.1425179095695;5537.307836520435;5426.565874730091;5452.236686863763;5456.972715136399;5468.179773034077;5487.5884308677805;5587.385387607441;5589.071770239261;5592.944070559405;5600.411956744483;5609.859753506195;5237.371515418175;5473.370562385377;5489.835304940858;5493.807716729895;5494.120940649636 06:06:51 INFO - PROCESS | 30303 | |5;yui.html;802.3180296747765;813.6826637611331;858;864.6740268677254;865.8268346330735;14050.929745351272;15385.615359616002;15589.142597157152;15640.374385024585;15647.139407332592;13311.400986955587;13363.131396459223;13395.665108372272;13408.798868016987;13411.396487158077;680.7617333933133;789.3330136035041;816.7958010497375;817.1379194949326;817.4523069543391;797.972070977516;803.0764620686199;803.7186984555389;805.1545876829335;805.3034125481475;708.1961973160448;856.3620103023256;856.4989481153533;857.0358346859783;857.2970164465141;832.9458585191974;855.8972923249219;860.6643409070467;863.9611217495228;865.0614083719172;637.2798737426679;637.952153588478;638.1448858529593;638.269181786856;638.4030931079456;14348;14405;14508.492202772852;14524.854751452562;14526.854731452657;13268.270245136513;13573.321333933263;13576.253306068162;13598.456061757517;13677.521286754916;12103.273803571814;12128.939355303168;12294.385280735927;12455.501779928793;12530.373481325898;4444.577765112309;4517.503074661785;4585.610223131038;4590.793414296331;4644.7213167210075;56872.43127568713;57014.01560161679;57588;60374.39625603732;60486.39513604896;11357.493217741614;11381.772364552662;11536.653900382835;11545.249558778652;11756.94121529387;20763.79236207649;20920.895395522926;20987.8950605246;20989.68515472269;21062.894685526782;8601.182887625666;8631.223189912938;8675.262602678717;8760.780980475412;8763.298936085097;4819.2530157825595;4841.95158048422;4879.512048795092;4924.679895806833;4937.5556199942175;3336.7664263501324;3419.7948123112196;3421.5894092708536;3450.7929524228625;3457.22212502185;638.9393007664264;641.55091435995;650.2229835346715;657.1719633262029;660.3462572053633;636.9363063693594;653.5131327161296;778.283978739561;785.4815821557744;785.8585454618224;9498.477583732962;9639.951800240953;9944.502774861228;9945.602175912882;9947.80104397908;627.6641996531833;704.2605264472284;711.1324184494908;744.2408743082134;745.7837227204159;4576.613603760575;4632.420947381577;4640.257558790645;4657.6273898088075;4797.928031079537;65124.674376627816;67126;67245;69573.3042669577;69621;60661.393386066455;60789.392106079256;61296;61871.38128618746;63333.05000424997;55642.721786391616;55794.72102639461;56359;57460;57495.42504574984;9632;9773.657921972697;9774.266929980422;9813.705588832347;9822.75443113928;36062;37165.81417092897;37267.44098838465;37432.438513421774;38363.23273534458;45857;48119.27821082617;48211.517884822104;48293;50590.747046264536;12303.69240768988;12565.246085234916;12607.87392126067;12761.489540418279;12899.484020639446;13675.452981880613;13714.588562343146;14190.93145033313;14304.499342522962;14616.634584135481;13483.865161348262;13657.38541765603;13943.790843137564;14438.494652687106;14462.710745785236;13574.457021719416;13869.861301386856;13908.304584770924;14477;14497.420103196177;13057.28184949837;13222.933885330513;13482.52811151605;13505.932470337586;13552.457901683822;10859.2398532102;11043.558257669603;11118.722141147911;11284;11440.256383335056;11010;11460.19778615489;11468.369239691898;11540.653780386601;11562.364069976233 06:06:51 INFO - PROCESS | 30303 | __end_tp_report 06:06:51 INFO - PROCESS | 30303 | __start_cc_report 06:06:51 INFO - PROCESS | 30303 | _x_x_mozilla_cycle_collect,1145 06:06:51 INFO - PROCESS | 30303 | __end_cc_report 06:06:51 INFO - PROCESS | 30303 | __startTimestamp1464354411167__endTimestamp 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | ------- Summary: start ------- 06:06:51 INFO - PROCESS | 30303 | Number of tests: 6 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#0] dojo.html Cycles:165 Average:5297.77 Median:5492.29 stddev:609.72 (11.1%) stddev-sans-first:586.77 06:06:51 INFO - PROCESS | 30303 | Values: 3102.6 3105.0 3123.3 3124.6 3168.8 5174.4 5264.1 5277.6 5372.0 5399.2 5267.1 5303.9 5349.7 5357.3 5372.2 4581.8 4796.5 4903.3 4906.9 4927.3 4713.6 4884.0 4904.7 4924.0 4932.5 4760.3 4762.3 4784.0 4905.9 4916.8 4751.5 4754.5 4765.5 4810.3 4854.3 4763.5 4791.4 4796.2 4809.8 4854.1 5103.0 5171.5 5246.7 5336.8 5343.7 5737.5 5787.9 5790.6 5794.5 5796.7 5570.2 5801.0 5823.8 5824.1 5832.1 5305.2 5374.7 5393.6 5448.9 5456.9 5989.6 6003.3 6004.1 6005.7 6006.0 5436.4 5492.3 5739.7 5747.5 5750.4 5617.6 5680.3 5729.5 5740.5 5740.9 5610.3 5612.2 5616.6 5618.6 5627.2 5494.9 5575.9 5630.0 5631.7 5637.3 4302.3 4324.6 4359.0 4362.2 4370.5 3880.8 3882.8 3891.3 3927.0 3930.2 5219.4 5455.5 5463.3 5465.2 5467.2 5672.3 5727.6 5737.8 5749.7 5771.1 5444.6 5451.5 5454.5 5460.3 5461.3 4695.4 4730.2 4831.5 4839.6 4886.6 5837.7 5882.9 5897.4 5899.5 5944.8 5712.0 5713.1 5717.3 5718.0 5718.9 5749.7 5804.7 5846.3 5847.6 5865.8 5632.7 5646.5 5652.2 5653.8 5694.5 5623.6 5715.9 5719.8 5720.8 5734.7 5452.7 5570.0 5576.9 5624.4 5659.9 5607.9 5612.9 5625.4 5630.2 5640.2 5550.9 5553.4 5558.6 5559.1 5562.4 5419.3 5460.1 5563.1 5642.0 5647.9 5432.5 5469.3 5486.8 5494.3 5572.0 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#1] ext.html Cycles:180 Average:55530.77 Median:41745.48 stddev:102163.79 (244.7%) stddev-sans-first:102367.10 06:06:51 INFO - PROCESS | 30303 | Values: 585.7 614.7 618.3 636.9 649.3 31128.4 31660.7 33873.2 33913.5 43252.0 41878.4 46698.8 46703.0 46714.3 46737.3 8806.3 9021.4 9029.9 9029.9 9033.5 8850.2 8983.6 8984.6 8992.1 9003.6 9005.3 9072.0 9078.9 9081.7 9086.7 8950.4 8988.6 9015.0 9017.3 9019.5 8837.2 8928.4 8941.0 8942.4 8943.9 43492.3 43898.3 43926.6 43959.0 43987.3 3504.5 3628.3 3682.0 3689.4 4084.2 32358.0 32749.7 33027.5 33435.2 34307.6 4399.5 4446.5 4488.9 4493.0 4511.0 323913.0 324484.0 324855.0 325014.0 325747.0 54038.7 58280.0 59456.1 59869.0 59956.4 60377.7 64617.0 65148.0 65192.0 65247.0 16854.1 17144.3 17188.3 17188.4 17195.8 12194.9 12726.7 12740.8 12912.3 12963.4 18434.2 18567.5 18697.1 18710.7 18733.9 5967.5 5998.8 6059.4 6067.8 6294.0 925.5 992.6 1099.8 1103.9 1190.7 32272.0 32632.8 32995.3 33076.5 33169.7 1104.3 1107.6 1160.7 1227.8 1244.5 17233.4 17270.7 17444.5 17446.7 17640.7 491632.0 494280.0 495141.0 495392.0 499343.0 58256.1 58493.0 58538.7 58616.7 58721.7 1247.5 1341.9 1352.8 1356.4 1401.5 31807.5 32975.3 33299.5 33423.5 33855.2 50615.5 50893.7 51198.0 51202.2 51206.7 313769.0 313874.0 313910.0 315310.0 315445.0 36835.0 37763.8 43039.4 44480.6 46946.5 47796.0 48824.5 48971.0 49278.5 49345.5 40242.6 40998.6 41386.8 41612.6 41950.4 40587.6 40642.6 40796.6 41352.2 41970.0 40700.0 41090.9 41498.4 41564.6 41948.4 36654.5 37076.0 37490.6 37797.8 37943.2 28040.7 28149.6 28244.6 28413.9 28653.8 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#2] jquery.html Cycles:180 Average:28933.19 Median:12458.50 stddev:79704.31 (639.8%) stddev-sans-first:79899.07 06:06:51 INFO - PROCESS | 30303 | Values: 383.0 388.1 389.9 395.5 418.1 14468.3 16149.5 18088.9 19559.9 19578.9 14115.9 17053.5 17098.0 17535.6 18556.1 5525.7 5543.7 5721.4 5815.3 5818.5 4059.3 5694.8 5734.8 5793.3 6129.3 6403.4 6511.0 6524.1 6538.2 6539.1 6259.4 6452.1 6489.8 6541.7 6549.8 5556.8 5601.0 5608.1 5609.5 5614.6 21487.4 21833.6 22212.9 22519.7 22571.0 2346.0 2384.4 2516.8 2528.7 2564.4 13798.5 13893.9 13902.4 14181.9 14807.1 1870.0 1873.0 1897.7 1921.3 1964.4 75201.6 76894.6 77427.0 78439.6 79353.2 10500.2 10581.2 10674.8 10756.2 10827.9 14460.9 14565.3 14635.3 14636.6 14642.9 7231.3 7832.7 8080.3 8228.6 8371.8 7984.9 7996.6 8084.4 8195.9 8217.7 6524.4 6605.3 6653.9 6656.9 6658.9 1905.4 1931.9 1938.6 1946.9 1985.8 909.4 988.6 988.9 1043.1 1114.0 17525.8 18810.5 19051.8 19930.8 20208.0 957.4 1009.9 1018.3 1041.7 1060.5 10462.9 10586.1 10594.7 10660.1 10679.3 471098.0 482564.0 484887.0 486293.0 488995.0 94787.5 97108.5 97672.0 97877.5 98057.0 1035.3 1056.0 1065.1 1066.6 1067.2 16669.1 16764.2 17037.2 17159.9 17336.9 41201.0 42472.0 42832.8 42999.4 44334.8 53964.0 55685.0 62402.7 63152.0 63463.4 8321.2 8341.6 8455.9 8516.7 8596.7 12886.2 12985.2 13080.4 13192.1 13553.5 11643.8 11868.4 11881.3 11891.8 12076.4 10928.8 11447.4 11490.5 11506.7 11598.1 11795.8 12029.3 12034.1 12154.5 12290.8 8408.6 8464.9 8486.2 8487.3 8566.2 10392.2 11561.2 11654.6 12029.7 12092.0 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#3] mootools.html Cycles:180 Average:5676.72 Median:4776.78 stddev:3277.51 (68.6%) stddev-sans-first:3270.83 06:06:51 INFO - PROCESS | 30303 | Values: 1383.9 1533.2 1549.7 1731.8 1869.2 8475.4 8880.2 8891.0 9089.3 9090.1 8874.6 9057.5 9057.6 9074.1 9086.5 1952.0 2223.5 2261.4 2279.9 2289.7 2263.9 2277.8 2277.9 2278.9 2284.8 2263.3 2269.1 2269.5 2285.5 2287.8 1913.2 1974.2 2110.7 2170.0 2179.9 2206.5 2229.8 2230.0 2231.7 2235.2 8353.5 8380.3 8392.5 8394.2 8397.9 4896.8 4970.1 4990.7 4999.9 5007.5 3166.9 3249.5 3352.4 3384.1 3402.0 1031.1 1052.7 1076.3 1086.4 1088.3 11486.3 11557.9 11570.6 11594.2 11681.6 4399.8 4431.3 4476.1 4534.8 4541.6 9963.7 9967.9 9974.2 9989.1 10000.6 5001.0 5030.6 5035.9 5038.0 5040.0 4115.8 4434.4 4545.9 4550.0 4590.6 3841.0 3912.5 3951.5 3983.5 4043.1 1197.2 1198.4 1211.1 1224.1 1225.5 781.8 942.5 956.1 957.9 969.7 6023.1 6025.7 6090.6 6138.4 6159.1 435.8 438.7 438.7 441.8 445.3 4106.6 4195.2 4204.2 4211.3 4224.1 10663.4 10912.2 11029.8 11040.2 11061.9 10862.1 10892.3 10936.8 10959.2 10988.8 7822.4 8194.6 8198.5 8201.1 8301.4 5900.2 5959.5 5997.4 6050.3 6069.6 9489.9 9544.8 9545.4 9581.0 9582.0 9718.9 9988.6 10030.6 10112.4 10164.7 6925.0 7724.6 7948.0 7951.6 8094.6 8896.3 8906.4 8936.4 8937.8 8956.1 7321.7 7364.2 7368.9 7728.7 8005.9 7186.2 7205.3 7274.9 7373.4 7451.7 6938.2 6959.0 6962.3 6973.2 6985.7 4702.1 4759.4 4794.1 4911.2 4940.3 4840.9 4862.2 4862.5 4933.8 4938.3 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#4] prototype.html Cycles:180 Average:4548.96 Median:5113.26 stddev:1335.75 (26.1%) stddev-sans-first:1300.97 06:06:51 INFO - PROCESS | 30303 | Values: 305.7 319.8 320.7 332.6 333.5 5212.4 5254.2 5274.7 5332.4 5341.7 5150.4 5220.9 5228.5 5230.8 5249.3 4070.7 4089.5 4131.8 4135.3 4146.0 4055.5 4098.0 4132.7 4145.2 4149.3 4108.9 4115.9 4118.0 4118.7 4118.9 4099.5 4103.7 4105.1 4124.2 4126.9 3618.5 3650.2 3655.1 3690.3 3697.6 4844.5 5010.3 5020.8 5054.4 5149.9 4633.9 4664.2 4686.2 4690.8 4703.7 5410.6 5426.5 5431.4 5466.3 5497.9 3673.4 3877.6 3888.3 3909.4 3953.1 5332.3 5515.9 5672.2 5674.1 5684.8 3957.8 3960.6 3961.4 3966.8 3970.9 3776.6 3989.2 4055.0 4089.6 4104.6 4601.4 4650.7 4654.7 4691.4 4703.9 5425.6 5491.1 5502.1 5515.4 5548.6 1411.4 1424.2 1454.3 1456.5 1456.7 939.3 941.0 950.9 958.2 962.7 4714.5 4735.3 4771.4 4791.5 4858.7 5003.6 5008.6 5020.9 5025.7 5036.7 4439.4 4756.5 4773.3 4790.4 4819.0 2667.7 2670.5 2670.7 2671.9 2683.6 5104.0 5160.9 5164.7 5175.7 5186.5 5076.3 5122.5 5130.6 5374.8 5872.4 5863.0 5935.2 5963.6 5974.4 5974.8 5444.2 5679.3 5680.9 5707.1 5737.9 5237.5 5556.4 5597.8 5606.7 5619.6 5807.7 5817.3 5839.0 5893.8 5902.5 3938.2 3997.5 4009.2 4030.7 4063.8 5566.7 5606.1 5639.8 5646.2 5685.7 5458.6 5484.4 5517.1 5517.3 5544.8 5269.0 5514.2 5518.9 5532.1 5537.3 5426.6 5452.2 5457.0 5468.2 5487.6 5587.4 5589.1 5592.9 5600.4 5609.9 5237.4 5473.4 5489.8 5493.8 5494.1 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - PROCESS | 30303 | [#5] yui.html Cycles:180 Average:15959.15 Median:26458.60 stddev:18771.62 (70.9%) stddev-sans-first:18789.77 06:06:51 INFO - PROCESS | 30303 | Values: 802.3 813.7 858.0 864.7 865.8 14050.9 15385.6 15589.1 15640.4 15647.1 13311.4 13363.1 13395.7 13408.8 13411.4 680.8 789.3 816.8 817.1 817.5 798.0 803.1 803.7 805.2 805.3 708.2 856.4 856.5 857.0 857.3 832.9 855.9 860.7 864.0 865.1 637.3 638.0 638.1 638.3 638.4 14348.0 14405.0 14508.5 14524.9 14526.9 13268.3 13573.3 13576.3 13598.5 13677.5 12103.3 12128.9 12294.4 12455.5 12530.4 4444.6 4517.5 4585.6 4590.8 4644.7 56872.4 57014.0 57588.0 60374.4 60486.4 11357.5 11381.8 11536.7 11545.2 11756.9 20763.8 20920.9 20987.9 20989.7 21062.9 8601.2 8631.2 8675.3 8760.8 8763.3 4819.3 4842.0 4879.5 4924.7 4937.6 3336.8 3419.8 3421.6 3450.8 3457.2 638.9 641.6 650.2 657.2 660.3 636.9 653.5 778.3 785.5 785.9 9498.5 9640.0 9944.5 9945.6 9947.8 627.7 704.3 711.1 744.2 745.8 4576.6 4632.4 4640.3 4657.6 4797.9 65124.7 67126.0 67245.0 69573.3 69621.0 60661.4 60789.4 61296.0 61871.4 63333.1 55642.7 55794.7 56359.0 57460.0 57495.4 9632.0 9773.7 9774.3 9813.7 9822.8 36062.0 37165.8 37267.4 37432.4 38363.2 45857.0 48119.3 48211.5 48293.0 50590.7 12303.7 12565.2 12607.9 12761.5 12899.5 13675.5 13714.6 14190.9 14304.5 14616.6 13483.9 13657.4 13943.8 14438.5 14462.7 13574.5 13869.9 13908.3 14477.0 14497.4 13057.3 13222.9 13482.5 13505.9 13552.5 10859.2 11043.6 11118.7 11284.0 11440.3 11010.0 11460.2 11468.4 11540.7 11562.4 06:06:51 INFO - PROCESS | 30303 | -------- Summary: end -------- 06:06:51 INFO - PROCESS | 30303 | 06:06:51 INFO - TEST-INFO | 30303: exit 0 06:06:51 INFO - TEST-OK | dromaeo_css | took 1112052ms 06:06:51 INFO - TEST-START | kraken 06:06:51 INFO - operating with platform_type : linux_ 06:06:51 INFO - Initialising browser for kraken test... 06:06:51 INFO - TEST-INFO | started process 30477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhQJnv/profile http://localhost:60200/getInfo.html) 06:06:55 INFO - PROCESS | 30477 | __metrics Screen width/height:1600/1200 06:06:55 INFO - PROCESS | 30477 | colorDepth:24 06:06:55 INFO - PROCESS | 30477 | Browser inner width/height: 1024/697 06:06:55 INFO - PROCESS | 30477 | __metrics 06:06:56 ERROR - PROCESS | 30477 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:06:57 INFO - TEST-INFO | 30477: exit 0 06:06:57 INFO - Browser initialized. 06:06:57 INFO - Running cycle 1/1 for kraken test... 06:06:57 INFO - TEST-INFO | started process 30561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhQJnv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:09 INFO - PROCESS | 30561 | RSS: Main: 155332608 06:07:09 INFO - PROCESS | 30561 | 06:07:11 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:12 INFO - PROCESS | 30561 | RSS: Main: 213893120 06:07:12 INFO - PROCESS | 30561 | 06:07:15 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-dft) 06:07:15 INFO - PROCESS | 30561 | RSS: Main: 200003584 06:07:15 INFO - PROCESS | 30561 | 06:07:18 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-fft) 06:07:19 INFO - PROCESS | 30561 | RSS: Main: 268562432 06:07:19 INFO - PROCESS | 30561 | 06:07:21 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-oscillator) 06:07:22 INFO - PROCESS | 30561 | RSS: Main: 179171328 06:07:22 INFO - PROCESS | 30561 | 06:07:24 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:24 INFO - PROCESS | 30561 | RSS: Main: 183582720 06:07:24 INFO - PROCESS | 30561 | 06:07:27 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:28 INFO - PROCESS | 30561 | RSS: Main: 218353664 06:07:28 INFO - PROCESS | 30561 | 06:07:31 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:32 INFO - PROCESS | 30561 | RSS: Main: 219840512 06:07:32 INFO - PROCESS | 30561 | 06:07:35 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60200/tests/kraken/driver.html?testName=json-parse-financial) 06:07:35 INFO - PROCESS | 30561 | RSS: Main: 219967488 06:07:35 INFO - PROCESS | 30561 | 06:07:37 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:37 INFO - PROCESS | 30561 | RSS: Main: 208527360 06:07:37 INFO - PROCESS | 30561 | 06:07:39 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:40 INFO - PROCESS | 30561 | RSS: Main: 211443712 06:07:40 INFO - PROCESS | 30561 | 06:07:42 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:43 INFO - PROCESS | 30561 | RSS: Main: 219455488 06:07:43 INFO - PROCESS | 30561 | 06:07:45 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:46 INFO - PROCESS | 30561 | RSS: Main: 223440896 06:07:46 INFO - PROCESS | 30561 | 06:07:48 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:49 INFO - PROCESS | 30561 | RSS: Main: 222973952 06:07:49 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60200/tests/kraken/driver.html?testName=ai-astar) 06:07:51 INFO - PROCESS | 30561 | RSS: Main: 264921088 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | __start_tp_report 06:07:51 INFO - PROCESS | 30561 | _x_x_mozilla_page_load 06:07:51 INFO - PROCESS | 30561 | _x_x_mozilla_page_load_details 06:07:51 INFO - PROCESS | 30561 | |i|pagename|runs| 06:07:51 INFO - PROCESS | 30561 | |0;ai-astar;109;108;109;109;110;109;110;110;108;110 06:07:51 INFO - PROCESS | 30561 | |1;audio-beat-detection;159;125;126;180;129;127;153;126;156;126 06:07:51 INFO - PROCESS | 30561 | |2;audio-dft;160;160;160;160;159;159;161;160;160;161 06:07:51 INFO - PROCESS | 30561 | |3;audio-fft;74;74;76;109;76;76;74;75;111;74 06:07:51 INFO - PROCESS | 30561 | |4;audio-oscillator;83;83;122;83;83;84;119;83;82;134 06:07:51 INFO - PROCESS | 30561 | |5;imaging-gaussian-blur;118;117;117;117;117;116;116;117;117;117 06:07:51 INFO - PROCESS | 30561 | |6;imaging-darkroom;147;146;148;146;146;147;146;146;146;147 06:07:51 INFO - PROCESS | 30561 | |7;imaging-desaturate;96;96;96;96;95;95;94;95;95;95 06:07:51 INFO - PROCESS | 30561 | |8;json-parse-financial;53;53;53;53;52;52;54;52;52;53 06:07:51 INFO - PROCESS | 30561 | |9;json-stringify-tinderbox;61;61;61;61;60;61;60;61;61;62 06:07:51 INFO - PROCESS | 30561 | |10;stanford-crypto-aes;81;84;81;78;79;80;81;82;126;79 06:07:51 INFO - PROCESS | 30561 | |11;stanford-crypto-ccm;120;119;119;119;118;126;126;123;131;120 06:07:51 INFO - PROCESS | 30561 | |12;stanford-crypto-pbkdf2;160;158;162;158;161;162;164;156;157;156 06:07:51 INFO - PROCESS | 30561 | |13;stanford-crypto-sha256-iterative;63;62;63;64;62;65;62;62;61;63 06:07:51 INFO - PROCESS | 30561 | __end_tp_report 06:07:51 INFO - PROCESS | 30561 | __start_cc_report 06:07:51 INFO - PROCESS | 30561 | _x_x_mozilla_cycle_collect,1700 06:07:51 INFO - PROCESS | 30561 | __end_cc_report 06:07:51 INFO - PROCESS | 30561 | __startTimestamp1464354471428__endTimestamp 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | ------- Summary: start ------- 06:07:51 INFO - PROCESS | 30561 | Number of tests: 14 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 06:07:51 INFO - PROCESS | 30561 | Values: 109.0 108.0 109.0 109.0 110.0 109.0 110.0 110.0 108.0 110.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:141.00 stddev:19.68 (14.0%) stddev-sans-first:19.72 06:07:51 INFO - PROCESS | 30561 | Values: 159.0 125.0 126.0 180.0 129.0 127.0 153.0 126.0 156.0 126.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 06:07:51 INFO - PROCESS | 30561 | Values: 160.0 160.0 160.0 160.0 159.0 159.0 161.0 160.0 160.0 161.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:14.84 (19.9%) stddev-sans-first:15.47 06:07:51 INFO - PROCESS | 30561 | Values: 74.0 74.0 76.0 109.0 76.0 76.0 74.0 75.0 111.0 74.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.00 stddev:20.64 (24.9%) stddev-sans-first:21.38 06:07:51 INFO - PROCESS | 30561 | Values: 83.0 83.0 122.0 83.0 83.0 84.0 119.0 83.0 82.0 134.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:07:51 INFO - PROCESS | 30561 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:07:51 INFO - PROCESS | 30561 | Values: 147.0 146.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:07:51 INFO - PROCESS | 30561 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 06:07:51 INFO - PROCESS | 30561 | Values: 53.0 53.0 53.0 53.0 52.0 52.0 54.0 52.0 52.0 53.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:07:51 INFO - PROCESS | 30561 | Values: 61.0 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 62.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:81.00 stddev:14.47 (17.9%) stddev-sans-first:15.27 06:07:51 INFO - PROCESS | 30561 | Values: 81.0 84.0 81.0 78.0 79.0 80.0 81.0 82.0 126.0 79.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:121.50 stddev:4.28 (3.5%) stddev-sans-first:4.47 06:07:51 INFO - PROCESS | 30561 | Values: 120.0 119.0 119.0 119.0 118.0 126.0 126.0 123.0 131.0 120.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.50 stddev:2.80 (1.7%) stddev-sans-first:2.96 06:07:51 INFO - PROCESS | 30561 | Values: 160.0 158.0 162.0 158.0 161.0 162.0 164.0 156.0 157.0 156.0 06:07:51 INFO - PROCESS | 30561 | 06:07:51 INFO - PROCESS | 30561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 06:07:51 INFO - PROCESS | 30561 | Values: 63.0 62.0 63.0 64.0 62.0 65.0 62.0 62.0 61.0 63.0 06:07:51 INFO - PROCESS | 30561 | -------- Summary: end -------- 06:07:51 INFO - PROCESS | 30561 | 06:07:52 INFO - TEST-INFO | 30561: exit 0 06:07:52 INFO - TEST-OK | kraken | took 60455ms 06:07:52 INFO - SUITE-END | took 1172s 06:07:52 INFO - Completed test suite (00:19:32) 06:07:52 INFO - javascript benchmark 06:07:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.627684677838, 3105.037438394098, 3123.312871168342, 3124.6250449946, 3168.841557922103, 5174.43081261061, 5264.078786212417, 5277.551408130309, 5371.973140134299, 5399.217113518537, 5267.051930652481, 5303.946960530394, 5349.732513374335, 5357.276767636377, 5372.167314066326, 4581.79381927814, 4796.544328288815, 4903.2645103234445, 4906.9263961040615, 4927.2609108633815, 4713.622910167179, 4883.9511604883855, 4904.730239836807, 4923.950760492385, 4932.482089380617, 4760.262159365287, 4762.3094651275715, 4783.976080119612, 4905.8773530661665, 4916.827911023132, 4751.4535828379485, 4754.477007529169, 4765.499622539618, 4810.326554282403, 4854.344663470457, 4763.452202996665, 4791.448983366922, 4796.160671882441, 4809.807607695688, 4854.101991131617, 5102.974485127587, 5171.534561889411, 5246.685198888041, 5336.813211537617, 5343.65266257692, 5737.454941780524, 5787.884242315172, 5790.594658373915, 5794.5074668653215, 5796.710164491801, 5570.2480165177585, 5801.0, 5823.82528524145, 5824.126381042835, 5832.066869300934, 5305.151175811851, 5374.7043912584795, 5393.649412788156, 5448.891022179574, 5456.91814622781, 5989.55078369124, 6003.309619393825, 6004.099385092184, 6005.669688167192, 6006.018014055351, 5436.374816896107, 5492.286002819608, 5739.65562066269, 5747.511461525817, 5750.396208398141, 5617.634853734494, 5680.261565996477, 5729.4843464088435, 5740.512056475163, 5740.885182296331, 5610.298712660918, 5612.242347283146, 5616.550675945996, 5618.550515958714, 5627.240322556402, 5494.945050549443, 5575.8884822304135, 5630.0, 5631.746571404296, 5637.295338082739, 4302.333138363559, 4324.610785029363, 4358.956410435919, 4362.192994296065, 4370.54109318517, 3880.8059597020037, 3882.8058597070035, 3891.3384724596885, 3926.960730392717, 3930.1746633206776, 5219.42586315505, 5455.481729235717, 5463.289772329572, 5465.180222966507, 5467.234587157801, 5672.262605861294, 5727.627704199213, 5737.799177028784, 5749.655020698688, 5771.076627739541, 5444.618876678674, 5451.509364157166, 5454.4545545445935, 5460.262864513319, 5461.344638643388, 4695.413073365829, 4730.195866702668, 4831.51684831514, 4839.612830973514, 4886.584640305543, 5837.708114594253, 5882.9116613425795, 5897.410258974069, 5899.469047785634, 5944.791932282349, 5711.971440142773, 5713.057345538023, 5717.256756621613, 5718.0, 5718.914216286842, 5749.655020698771, 5804.6807425592, 5846.298444186725, 5847.649141051551, 5865.765369385347, 5632.662040277596, 5646.463585959327, 5652.180433836988, 5653.830385088454, 5694.544436444991, 5623.606347555796, 5715.94255062798, 5719.828405147852, 5720.8283751487525, 5734.655920644775, 5452.727363631882, 5569.972150139223, 5576.888462230651, 5624.409437009055, 5659.886802264014, 5607.915881261866, 5612.8877422450505, 5625.371635295293, 5630.18362337467, 5640.210370548045, 5550.861228469321, 5553.389127196086, 5558.555315574664, 5559.082751345983, 5562.415946325739, 5419.2954915862265, 5460.126379779216, 5563.05428077236, 5641.971790141023, 5647.943520564741, 5432.511074003359, 5469.2616496772425, 5486.835394938158, 5494.340679118532, 5572.024895643327], "value": 5256.666517538776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.7159277750293, 614.741808440455, 618.2611778924185, 636.8789929913313, 649.2890285137775, 31128.377432451336, 31660.683393166062, 33873.1531711707, 33913.49129763049, 43252.0, 41878.371824422655, 46698.76650616742, 46703.0, 46714.299285510744, 46737.29894051592, 8806.251468625174, 9021.413608115452, 9029.909700903005, 9029.909700903005, 9033.548322583878, 8850.247728943015, 8983.55082245885, 8984.595693193789, 8992.05583413742, 9003.594838232262, 9005.279577633773, 9072.047435019327, 9078.909210907905, 9081.727548173532, 9086.681966131187, 8950.418222815497, 8988.550572471415, 9015.008349081629, 9017.323700722407, 9019.503927283997, 8837.204651581324, 8928.419652722552, 8941.0, 8942.374033817636, 8943.865842012376, 43492.3476147858, 43898.34152487715, 43926.560734392886, 43959.0, 43987.34018989686, 3504.5268888700207, 3628.32875917956, 3682.042668906077, 3689.4465830125428, 4084.2239974405065, 32358.0, 32749.67250327514, 33027.504587431205, 33435.16412089693, 34307.62769489217, 4399.494058183286, 4446.510883802779, 4488.887777805581, 4492.977535112336, 4510.954890451087, 323913.0, 324484.0, 324854.9999999976, 325014.0, 325747.0, 54038.72980635072, 58280.0, 59456.10815837766, 59869.0, 59956.40043599595, 60377.69811151004, 64617.0, 65148.0, 65192.0, 65247.0, 16854.07302598344, 17144.314227431012, 17188.31246750116, 17188.398406055727, 17195.828041719422, 12194.878051219552, 12726.745465090646, 12740.808887866504, 12912.289824059579, 12963.351832408342, 18434.170462329228, 18567.535811604546, 18697.065146742607, 18710.71933920992, 18733.906330468533, 5967.522598192134, 5998.760049597967, 6059.394060593905, 6067.787627433018, 6293.968530157412, 925.5233554719325, 992.5509250792221, 1099.7910397024539, 1103.8840921703265, 1190.7082764722525, 32272.031839044867, 32632.83683581567, 32995.340093198, 33076.503852441754, 33169.66884056903, 1104.2987702808775, 1107.6123356825046, 1160.721426857565, 1227.8035514317844, 1244.5333000124954, 17233.39683111085, 17270.654586908193, 17444.47666570005, 17446.738298925527, 17640.735388969177, 491632.0, 494280.0, 495141.0, 495392.0, 499343.0, 58256.12615810766, 58493.0, 58538.7073064632, 58616.706916466, 58721.70639146777, 1247.544646204147, 1341.8591047939826, 1352.8444228913604, 1356.4438580182077, 1401.474447082344, 31807.522887157174, 32975.34049319048, 33299.50050749289, 33423.49864752079, 33855.15362115967, 50615.49384506255, 50893.74553127211, 51198.0, 51202.23196652128, 51206.74396627993, 313769.0, 313874.0, 313910.0, 315310.0, 315445.0, 36835.0, 37763.81118094392, 43039.354409683256, 44480.555194448934, 46946.53053469422, 47796.0, 48824.511754882, 48971.0, 49278.507214928824, 49345.50654493409, 40242.59757402506, 40998.59001410067, 41386.79306603448, 41612.58387416208, 41950.37074443947, 40587.59412405838, 40642.59357406506, 40796.592034080466, 41352.1729565401, 41970.0, 40700.0, 41090.89091090867, 41498.37752433655, 41564.58435415607, 41948.37077443902, 36654.450183246736, 37076.0, 37490.62509374871, 37797.811010944766, 37943.2411351777, 28040.71959280381, 28149.57775633408, 28244.576331354634, 28413.857930710215, 28653.841380166316], "value": 20168.57446540082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.0041891083183, 388.07392262341943, 389.85575337125266, 395.5352460858492, 418.09482470451474, 14468.276586170701, 16149.515514534552, 18088.90955545222, 19559.902200488996, 19578.902105489487, 14115.858841411582, 17053.48839534816, 17098.0, 17535.5616109597, 18556.07219639016, 5525.668459892419, 5543.667379957205, 5721.399253078429, 5815.273090863642, 5818.5345172386105, 4059.3099173140636, 5694.800681976131, 5734.770609175628, 5793.304803423595, 6129.325774164839, 6403.423691867731, 6511.0, 6524.0540121682325, 6538.1827271591055, 6539.149910511651, 6259.37406259375, 6452.0967064610995, 6489.772857949973, 6541.705623246965, 6549.836254093662, 5556.805511807108, 5600.971995140039, 5608.130739735348, 5609.52319052881, 5614.63504872182, 21487.35537933849, 21833.563328733497, 22212.88893555522, 22519.662205066936, 22571.0, 2346.0, 2384.4396566806786, 2516.773490385874, 2528.734482879308, 2564.435824118691, 13798.517051903236, 13893.861061389358, 13902.443902243898, 14181.85818141826, 14807.111573305636, 1869.9906500467546, 1872.953176170593, 1897.724829899657, 1921.327535362626, 1964.4204959536971, 75201.62399188023, 76894.61552692257, 77427.0, 78439.60780196119, 79353.20646793516, 10500.212484063726, 10581.153507719364, 10674.839877401846, 10756.19328550362, 10827.891721082846, 14460.85539144616, 14565.344559494848, 14635.268236588341, 14636.634084147769, 14642.85357146415, 7231.2768723127265, 7832.725854595062, 8080.313173380211, 8228.588570571448, 8371.790705232417, 7984.920150798418, 7996.600169991593, 8084.434089613671, 8195.877061844078, 8217.671293148207, 6524.380183882524, 6605.30644282353, 6653.933460665428, 6656.933430665728, 6658.9001164982565, 1905.361703829205, 1931.9323823666105, 1938.5928954919625, 1946.8734532255357, 1985.7802170387927, 909.3952521573212, 988.614440368257, 988.8615593816728, 1043.1446214104512, 1113.9665810025713, 17525.824741752418, 18810.52973675669, 19051.809481905282, 19930.800691993183, 20208.0, 957.3681370295571, 1009.9091081802673, 1018.2973748113777, 1041.739565108723, 1060.5439660945713, 10462.947685261524, 10586.100181484506, 10594.735131621617, 10660.081185386549, 10679.252452328417, 471098.0, 482564.0, 484887.0, 486293.0, 488995.0, 94787.52606237063, 97108.51445742726, 97672.0, 97877.51061244648, 98057.0, 1035.2804800663466, 1055.9736006599896, 1065.1212749481708, 1066.6053560182781, 1067.1782727299935, 16669.083200424095, 16764.1617919106, 17037.233324500674, 17159.914200428917, 17336.913315433343, 41201.0, 42472.0, 42832.78583607062, 42999.355009675506, 44334.778326108164, 53964.0, 55685.0, 62402.68798655977, 63152.0, 63463.365366345744, 8321.167883211872, 8341.582920854054, 8455.873161902453, 8516.659333626585, 8596.656133754579, 12886.226826390446, 12985.155964862253, 13080.411381488046, 13192.076554641082, 13553.525626603021, 11643.825342619699, 11868.40657967081, 11881.346525941157, 11891.821622675494, 12076.396180191132, 10928.781424371628, 11447.427628618703, 11490.48292826808, 11506.654800356002, 11598.130140239684, 11795.823062653895, 12029.338386388832, 12034.097442691658, 12154.453049612965, 12290.815637765261, 8408.621612027597, 8464.915350846659, 8486.19381158789, 8487.321014318963, 8566.18621230982, 10392.168626510012, 11561.248518846249, 11654.592089276835, 12029.699257518632, 12092.0], "value": 9381.103435047125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.9238841863694, 1533.2333833083458, 1549.7055559443704, 1731.844134027938, 1869.23361421817, 8475.364347673925, 8880.156385143417, 8891.02198758137, 9089.272858171347, 9090.136437038487, 8874.645014199425, 9057.547122643875, 9057.592408341625, 9074.137956894101, 9086.454812711241, 1952.0142328124277, 2223.466368071667, 2261.42333704905, 2279.931602051941, 2289.7023386959672, 2263.909443622253, 2277.7836105569945, 2277.8633282003134, 2278.8632682039047, 2284.8400611957168, 2263.2757517594378, 2269.0810221860174, 2269.50070984384, 2285.5086156476355, 2287.805536529397, 1913.2251438167564, 1974.220183027696, 2110.6728457089175, 2170.0343347210496, 2179.8583092099043, 2206.5145667953025, 2229.7547269800307, 2230.0, 2231.654093615492, 2235.1953296813135, 8353.540555269457, 8380.329573634095, 8392.454490458162, 8394.202550757669, 8397.874031889527, 4896.779644915988, 4970.080535100982, 4990.675606085593, 4999.925001124986, 5007.524285192901, 3166.857491412869, 3249.545063691085, 3352.379809735207, 3384.120128766514, 3401.9659803401896, 1031.0771859186061, 1052.6631477927067, 1076.2735153771252, 1086.3536195963388, 1088.3089238333637, 11486.253393529478, 11557.884421155764, 11570.59502917394, 11594.246373985665, 11681.649550513499, 4399.802008909607, 4431.313146462304, 4476.149531588988, 4534.79593418297, 4541.591256786905, 9963.701088967342, 9967.900320996698, 9974.20206383502, 9989.100980911753, 10000.649977250761, 5001.0, 5030.572401345927, 5035.874103147377, 5038.0, 5039.974800125976, 4115.794210289533, 4434.379186913835, 4545.931811022837, 4549.954500455019, 4590.563896429834, 3841.0, 3912.5304963404574, 3951.5060617422823, 3983.50206224222, 4043.130726893732, 1197.1500234833366, 1198.370855300974, 1211.1158854036603, 1224.1002862895764, 1225.4669218889812, 781.8201813582908, 942.4863449419945, 956.0917128727737, 957.8515330123842, 969.6896992962326, 6023.0619477861, 6025.698715064229, 6090.604110732788, 6138.447539721446, 6159.137720719103, 435.7646870689792, 438.6841474138615, 438.7038748844517, 441.7813182474696, 445.274203049028, 4106.589341065929, 4195.160967806451, 4204.2432362175105, 4211.284081706117, 4224.091820258598, 10663.360198388122, 10912.181586381053, 11029.779404411867, 11040.171987101, 11061.944690276498, 10862.076723478593, 10892.292001019909, 10936.781264374667, 10959.232853700165, 10988.835167472495, 7822.374210063182, 8194.631241594143, 8198.467099638623, 8201.056878459054, 8301.418900676894, 5900.173975643327, 5959.463648271676, 5997.430244126976, 6050.30421501533, 6069.635821850703, 9489.857652135086, 9544.761380965254, 9545.379550329206, 9581.041895810364, 9582.0, 9718.854217186607, 9988.550515226978, 10030.64892728751, 10112.393256404639, 10164.745881353025, 6925.0, 7724.575148366894, 7948.0, 7951.602419879098, 8094.635741391534, 8896.332775042027, 8906.421082629608, 8936.41913275635, 8937.776555586162, 8956.104389561253, 7321.670524826289, 7364.226756190523, 7368.889466657897, 7728.652210650422, 8005.919940800751, 7186.173590037003, 7205.279472052753, 7274.927250727425, 7373.446991475768, 7451.664675089743, 6938.167419909643, 6959.0, 6962.303769622998, 6973.232944376013, 6985.685644145924, 4702.130105930414, 4759.42886853566, 4794.137055329935, 4911.214205727067, 4940.283658869515, 4840.854774356775, 4862.17343051675, 4862.489438608895, 4933.753312334297, 4938.30863679078], "value": 4438.799492513289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.7385935025553, 319.7665704036055, 320.65209247965953, 332.6307798343838, 333.5397151930336, 5212.400573933999, 5254.211868219769, 5274.736263186845, 5332.360116785986, 5341.706206158665, 5150.407703114143, 5220.903610241854, 5228.4771522847695, 5230.770768869313, 5249.291345668334, 4070.7177239169714, 4089.488813898255, 4131.7934103294865, 4135.296999510076, 4146.0, 4055.5336136344404, 4097.995990982198, 4132.6775431861815, 4145.233131870598, 4149.2531344358, 4108.8972775680695, 4115.917681646365, 4117.979410102946, 4118.732282401635, 4118.8673114893345, 4099.549049604541, 4103.651189648884, 4105.137921036586, 4124.216398884218, 4126.917461650765, 3618.5115009473648, 3650.233450975298, 3655.141041855162, 3690.2619476104887, 3697.630236976308, 4844.491328410501, 5010.273510341017, 5020.824271150492, 5054.418741844698, 5149.918517111411, 4633.907321853578, 4664.207084795593, 4686.172392766824, 4690.78039709678, 4703.717776933395, 5410.594205434569, 5426.484483974055, 5431.429699881495, 5466.289382380265, 5497.917531237034, 3673.3755261605324, 3877.6122387760997, 3888.319544079803, 3909.374500080002, 3953.1105501262273, 5332.253484512172, 5515.944840551623, 5672.234248376458, 5674.120511320752, 5684.8010319638615, 3957.782321972319, 3960.6435420812263, 3961.3661814110183, 3966.7619942803526, 3970.8808735737975, 3776.6034566370686, 3989.162275922031, 4055.0, 4089.631933126033, 4104.56902025289, 4601.4248218972625, 4650.674452788272, 4654.743989080565, 4691.366665500113, 4703.858884233478, 5425.565954723692, 5491.148871924858, 5502.0921547944945, 5515.393306736256, 5548.55611551075, 1411.3578321863527, 1424.173979092124, 1454.345544504977, 1456.4538298138198, 1456.730504856605, 939.3143005605809, 940.9952950235205, 950.9001554836642, 958.1903291718487, 962.7015625156224, 4714.45783734868, 4735.337052812609, 4771.403574553181, 4791.496892826203, 4858.65989380747, 5003.649744517848, 5008.5993120550265, 5020.949790502048, 5025.74871256443, 5036.697798132123, 4439.400680908101, 4756.500567440438, 4773.284007398918, 4790.377250957423, 4819.0, 2667.6928305130346, 2670.452557225764, 2670.7298796023615, 2671.879765410561, 2683.5974603809195, 5103.97448012765, 5160.92258616121, 5164.664296820694, 5175.689458632494, 5186.49591618434, 5076.289319495274, 5122.538971492583, 5130.640855140179, 5374.758135883894, 5872.412758724179, 5863.0, 5935.169076329317, 5963.642181469126, 5974.446643872624, 5974.761009559656, 5444.183372494158, 5679.34687510925, 5680.869673872298, 5707.08686610157, 5737.885242295214, 5237.528622424, 5556.361018482926, 5597.776088956396, 5606.747696353592, 5619.634723742944, 5807.651540907559, 5817.272840894888, 5839.0, 5893.793717219876, 5902.498287645427, 3938.2123575284486, 3997.5202975641946, 4009.2382447334912, 4030.717849750489, 4063.817128229296, 5566.749496272597, 5606.084835885398, 5639.774409023593, 5646.181303710857, 5685.749135190252, 5458.590605704509, 5484.436935473371, 5517.089680202722, 5517.337919449692, 5544.750486228048, 5268.9736551317, 5514.228008078792, 5518.944810552004, 5532.1425179095695, 5537.307836520435, 5426.565874730091, 5452.236686863763, 5456.972715136399, 5468.179773034077, 5487.5884308677805, 5587.385387607441, 5589.071770239261, 5592.944070559405, 5600.411956744483, 5609.859753506195, 5237.371515418175, 5473.370562385377, 5489.835304940858, 5493.807716729895, 5494.120940649636], "value": 4126.835109667226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.3180296747765, 813.6826637611331, 858.0, 864.6740268677254, 865.8268346330735, 14050.929745351272, 15385.615359616002, 15589.142597157152, 15640.374385024585, 15647.139407332592, 13311.400986955587, 13363.131396459223, 13395.665108372272, 13408.798868016987, 13411.396487158077, 680.7617333933133, 789.3330136035041, 816.7958010497375, 817.1379194949326, 817.4523069543391, 797.972070977516, 803.0764620686199, 803.7186984555389, 805.1545876829335, 805.3034125481475, 708.1961973160448, 856.3620103023256, 856.4989481153533, 857.0358346859783, 857.2970164465141, 832.9458585191974, 855.8972923249219, 860.6643409070467, 863.9611217495228, 865.0614083719172, 637.2798737426679, 637.952153588478, 638.1448858529593, 638.269181786856, 638.4030931079456, 14348.0, 14405.0, 14508.492202772852, 14524.854751452562, 14526.854731452657, 13268.270245136513, 13573.321333933263, 13576.253306068162, 13598.456061757517, 13677.521286754916, 12103.273803571814, 12128.939355303168, 12294.385280735927, 12455.501779928793, 12530.373481325898, 4444.577765112309, 4517.503074661785, 4585.610223131038, 4590.793414296331, 4644.7213167210075, 56872.43127568713, 57014.01560161679, 57588.0, 60374.39625603732, 60486.39513604896, 11357.493217741614, 11381.772364552662, 11536.653900382835, 11545.249558778652, 11756.94121529387, 20763.79236207649, 20920.895395522926, 20987.8950605246, 20989.68515472269, 21062.894685526782, 8601.182887625666, 8631.223189912938, 8675.262602678717, 8760.780980475412, 8763.298936085097, 4819.2530157825595, 4841.95158048422, 4879.512048795092, 4924.679895806833, 4937.5556199942175, 3336.7664263501324, 3419.7948123112196, 3421.5894092708536, 3450.7929524228625, 3457.22212502185, 638.9393007664264, 641.55091435995, 650.2229835346715, 657.1719633262029, 660.3462572053633, 636.9363063693594, 653.5131327161296, 778.283978739561, 785.4815821557744, 785.8585454618224, 9498.477583732962, 9639.951800240953, 9944.502774861228, 9945.602175912882, 9947.80104397908, 627.6641996531833, 704.2605264472284, 711.1324184494908, 744.2408743082134, 745.7837227204159, 4576.613603760575, 4632.420947381577, 4640.257558790645, 4657.6273898088075, 4797.928031079537, 65124.674376627816, 67126.0, 67245.0, 69573.3042669577, 69621.0, 60661.393386066455, 60789.392106079256, 61296.0, 61871.38128618746, 63333.05000424997, 55642.721786391616, 55794.72102639461, 56359.0, 57460.0, 57495.42504574984, 9632.0, 9773.657921972697, 9774.266929980422, 9813.705588832347, 9822.75443113928, 36062.0, 37165.81417092897, 37267.44098838465, 37432.438513421774, 38363.23273534458, 45857.0, 48119.27821082617, 48211.517884822104, 48293.0, 50590.747046264536, 12303.69240768988, 12565.246085234916, 12607.87392126067, 12761.489540418279, 12899.484020639446, 13675.452981880613, 13714.588562343146, 14190.93145033313, 14304.499342522962, 14616.634584135481, 13483.865161348262, 13657.38541765603, 13943.790843137564, 14438.494652687106, 14462.710745785236, 13574.457021719416, 13869.861301386856, 13908.304584770924, 14477.0, 14497.420103196177, 13057.28184949837, 13222.933885330513, 13482.52811151605, 13505.932470337586, 13552.457901683822, 10859.2398532102, 11043.558257669603, 11118.722141147911, 11284.0, 11440.256383335056, 11010.0, 11460.19778615489, 11468.369239691898, 11540.653780386601, 11562.364069976233], "value": 7088.0101345514095, "unit": "score"}], "name": "dromaeo_css", "value": 7109.664925342265, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 108.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 126.0, 180.0, 129.0, 127.0, 153.0, 126.0, 156.0, 126.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 159.0, 159.0, 161.0, 160.0, 160.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 109.0, 76.0, 76.0, 74.0, 75.0, 111.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 83.0, 83.0, 84.0, 119.0, 83.0, 82.0, 134.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 52.0, 52.0, 54.0, 52.0, 52.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 81.0, 78.0, 79.0, 80.0, 81.0, 82.0, 126.0, 79.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 119.0, 119.0, 118.0, 126.0, 126.0, 123.0, 131.0, 120.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 162.0, 158.0, 161.0, 162.0, 164.0, 156.0, 157.0, 156.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 62.0, 65.0, 62.0, 62.0, 61.0, 63.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1489.0, "alertThreshold": 2.0}]} 06:07:52 INFO - Return code: 0 06:07:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:07:52 ERROR - # TBPL SUCCESS # 06:07:52 INFO - Running post-action listener: _resource_record_post_action 06:07:52 INFO - ##### 06:07:52 INFO - ##### Finished run-tests step (success) 06:07:52 INFO - ##### 06:07:52 INFO - Running post-run listener: _resource_record_post_run 06:07:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541732864; Read time: 12; Write time: 412620 06:07:52 INFO - TinderboxPrint: CPU usage
13.1% 06:07:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:07:52 INFO - TinderboxPrint: I/O write bytes / time
541,732,864 / 412,620 06:07:52 INFO - TinderboxPrint: CPU idle
8,251.2 (86.9%) 06:07:52 INFO - TinderboxPrint: CPU user
1,205.4 (12.7%) 06:07:52 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246902784; Read time: 0; Write time: 210636 06:07:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294830080; Read time: 12; Write time: 201984 06:07:53 INFO - Running post-run listener: _upload_blobber_files 06:07:53 INFO - Blob upload gear active. 06:07:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:53 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:07:53 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:07:53 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:07:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:54 INFO - (blobuploader) - INFO - Done attempting. 06:07:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:55 INFO - (blobuploader) - INFO - Done attempting. 06:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:59 INFO - (blobuploader) - INFO - Done attempting. 06:07:59 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:59 INFO - Return code: 0 06:07:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128b5a7bed07f475e9dff63870799499f790d997af3f287e7cf574e9eb5e2e2e07a92315b1aca558504592c53d8744b8988c818810d1cbc77f0ad0b4dd950bbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d68e6a4559ef0a61f162ac08d9ce03060a0f0856d9ea17aa6310be545d7f1793f302efc35800b6b76f283055c6b9d433fca1ee54f1d254d0b47ba229b25632ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50e6ae2057bdc8c451e1d097ab783c5ec1689b603c716cd71bbb4c8d22803adb792c90c748bafea5c2cf999f9199016849c622773c64cb277764c5b6155a0bf9"} 06:07:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:59 INFO - Contents: 06:07:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128b5a7bed07f475e9dff63870799499f790d997af3f287e7cf574e9eb5e2e2e07a92315b1aca558504592c53d8744b8988c818810d1cbc77f0ad0b4dd950bbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d68e6a4559ef0a61f162ac08d9ce03060a0f0856d9ea17aa6310be545d7f1793f302efc35800b6b76f283055c6b9d433fca1ee54f1d254d0b47ba229b25632ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50e6ae2057bdc8c451e1d097ab783c5ec1689b603c716cd71bbb4c8d22803adb792c90c748bafea5c2cf999f9199016849c622773c64cb277764c5b6155a0bf9"} 06:07:59 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:59 INFO - Copying logs to upload dir... 06:07:59 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.046484 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-27 06:07:59.386086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 06:07:59.389989) ========= 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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 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/128b5a7bed07f475e9dff63870799499f790d997af3f287e7cf574e9eb5e2e2e07a92315b1aca558504592c53d8744b8988c818810d1cbc77f0ad0b4dd950bbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d68e6a4559ef0a61f162ac08d9ce03060a0f0856d9ea17aa6310be545d7f1793f302efc35800b6b76f283055c6b9d433fca1ee54f1d254d0b47ba229b25632ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50e6ae2057bdc8c451e1d097ab783c5ec1689b603c716cd71bbb4c8d22803adb792c90c748bafea5c2cf999f9199016849c622773c64cb277764c5b6155a0bf9"} build_url:https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/OIKkUSQsQkWs0qPyCrQ_ow/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/128b5a7bed07f475e9dff63870799499f790d997af3f287e7cf574e9eb5e2e2e07a92315b1aca558504592c53d8744b8988c818810d1cbc77f0ad0b4dd950bbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d68e6a4559ef0a61f162ac08d9ce03060a0f0856d9ea17aa6310be545d7f1793f302efc35800b6b76f283055c6b9d433fca1ee54f1d254d0b47ba229b25632ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50e6ae2057bdc8c451e1d097ab783c5ec1689b603c716cd71bbb4c8d22803adb792c90c748bafea5c2cf999f9199016849c622773c64cb277764c5b6155a0bf9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 06:07:59.415063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:07:59.415427) ========= 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=0333a256a5e4f052382dd180000001b1-1464353046.736696-1966743707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:07:59.500543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 06:07:59.500890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 06:07:59.501209) ========= ========= Total master_lag: 0.17 =========