builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1464110727.68 results: success (0) buildid: 20160524073714 builduid: 7ee183f8bd79495d83c3a17a699de4dc revision: 829d3be6ba64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.677628) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.678121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.678393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.755180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.755631) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 10:25:28-- 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% 17.9M=0.001s 2016-05-24 10:25:28 (17.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087291 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.856924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.857268) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.906754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:27.907110) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 829d3be6ba64 --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 829d3be6ba64 --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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 10:25:28,300 Setting DEBUG logging. 2016-05-24 10:25:28,300 attempt 1/10 2016-05-24 10:25:28,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/829d3be6ba64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 10:25:28,562 unpacking tar archive at: mozilla-central-829d3be6ba64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:28.492822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:28.493127) ========= script_repo_revision: 829d3be6ba64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:28.493524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:28.493804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:25:28.501949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 10:25:28.502222) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:25:28 INFO - MultiFileLogger online at 20160524 10:25:28 in /builds/slave/test 10:25:28 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 10:25:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:28 INFO - {'append_to_log': False, 10:25:28 INFO - 'base_work_dir': '/builds/slave/test', 10:25:28 INFO - 'blob_upload_branch': 'Firefox', 10:25:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:28 INFO - 'branch': 'Firefox', 10:25:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:28 INFO - 'config_files': ('talos/linux_config.py',), 10:25:28 INFO - 'default_actions': ('clobber', 10:25:28 INFO - 'read-buildbot-config', 10:25:28 INFO - 'download-and-extract', 10:25:28 INFO - 'populate-webroot', 10:25:28 INFO - 'create-virtualenv', 10:25:28 INFO - 'install', 10:25:28 INFO - 'run-tests'), 10:25:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:28 INFO - 'download_minidump_stackwalk': True, 10:25:28 INFO - 'download_symbols': 'ondemand', 10:25:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:28 INFO - 'installer_path': 'installer.exe', 10:25:28 INFO - 'log_level': 'info', 10:25:28 INFO - 'log_name': 'talos', 10:25:28 INFO - 'log_to_console': True, 10:25:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:25:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:25:28 INFO - 'opt_config_files': (), 10:25:28 INFO - 'pip_index': False, 10:25:28 INFO - 'sps_profile': False, 10:25:28 INFO - 'sps_profile_interval': 0, 10:25:28 INFO - 'suite': 'dromaeojs', 10:25:28 INFO - 'system_bits': '32', 10:25:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:28 INFO - 'title': 'talos-linux64-ix-042', 10:25:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:28 INFO - 'use_talos_json': True, 10:25:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:28 INFO - 'work_dir': 'build'} 10:25:28 INFO - ##### 10:25:28 INFO - ##### Running clobber step. 10:25:28 INFO - ##### 10:25:28 INFO - Running pre-action listener: _resource_record_pre_action 10:25:28 INFO - Running main action method: clobber 10:25:28 INFO - rmtree: /builds/slave/test/build 10:25:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:29 INFO - Running post-action listener: _resource_record_post_action 10:25:29 INFO - ##### 10:25:29 INFO - ##### Finished clobber step (success) 10:25:29 INFO - ##### 10:25:29 INFO - ##### 10:25:29 INFO - ##### Running read-buildbot-config step. 10:25:29 INFO - ##### 10:25:29 INFO - Running pre-action listener: _resource_record_pre_action 10:25:29 INFO - Running main action method: read_buildbot_config 10:25:29 INFO - Using buildbot properties: 10:25:29 INFO - { 10:25:29 INFO - "project": "", 10:25:29 INFO - "product": "firefox", 10:25:29 INFO - "script_repo_revision": "production", 10:25:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:25:29 INFO - "repository": "", 10:25:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:25:29 INFO - "buildid": "20160524073714", 10:25:29 INFO - "stage_platform": "linux64-pgo", 10:25:29 INFO - "basedir": "/builds/slave/test", 10:25:29 INFO - "nightly_build": "True", 10:25:29 INFO - "buildnumber": 775, 10:25:29 INFO - "slavename": "talos-linux64-ix-042", 10:25:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:25:29 INFO - "platform": "ubuntu64_hw", 10:25:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:25:29 INFO - "branch": "mozilla-central", 10:25:29 INFO - "repo_path": "mozilla-central", 10:25:29 INFO - "revision": "829d3be6ba64", 10:25:29 INFO - "pgo_build": "True", 10:25:29 INFO - "builduid": "7ee183f8bd79495d83c3a17a699de4dc", 10:25:29 INFO - "slavebuilddir": "test" 10:25:29 INFO - } 10:25:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:25:29 INFO - Running post-action listener: _resource_record_post_action 10:25:29 INFO - ##### 10:25:29 INFO - ##### Finished read-buildbot-config step (success) 10:25:29 INFO - ##### 10:25:29 INFO - ##### 10:25:29 INFO - ##### Running download-and-extract step. 10:25:29 INFO - ##### 10:25:29 INFO - Running pre-action listener: _resource_record_pre_action 10:25:29 INFO - Running main action method: download_and_extract 10:25:29 INFO - mkdir: /builds/slave/test/build/tests 10:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:29 INFO - https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:30 INFO - Downloaded 1361 bytes. 10:25:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:25:30 INFO - Using the following test package requirements: 10:25:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:25:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:25:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:25:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'jsshell-linux-x86_64.zip'], 10:25:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:25:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:25:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:25:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:25:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:25:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:25:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:30 INFO - https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:31 INFO - Downloaded 24416644 bytes. 10:25:31 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'] 10:25:31 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 10:25:32 INFO - Return code: 0 10:25:32 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 10:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:32 INFO - https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:25:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:25:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:25:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:34 INFO - Downloaded 24416644 bytes. 10:25:34 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'] 10:25:34 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 10:25:35 INFO - Return code: 0 10:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:35 INFO - https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:36 INFO - Downloaded 10840359 bytes. 10:25:36 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'] 10:25:36 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 10:25:36 INFO - Return code: 0 10:25:36 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')]} 10:25:36 INFO - https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3z5HXA8SCqY1hs-XREbkg/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 10:25:38 INFO - Downloaded 58620497 bytes. 10:25:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:25:38 INFO - mkdir: /builds/slave/test/properties 10:25:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:38 INFO - Contents: 10:25:38 INFO - build_url:https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:25:38 INFO - Running post-action listener: _resource_record_post_action 10:25:38 INFO - Running post-action listener: set_extra_try_arguments 10:25:38 INFO - ##### 10:25:38 INFO - ##### Finished download-and-extract step (success) 10:25:38 INFO - ##### 10:25:38 INFO - ##### 10:25:38 INFO - ##### Running populate-webroot step. 10:25:38 INFO - ##### 10:25:38 INFO - Running pre-action listener: _resource_record_pre_action 10:25:38 INFO - Running main action method: populate_webroot 10:25:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:38 INFO - '--tppagecycles', 10:25:38 INFO - '7'], 10:25:38 INFO - 'tests': ['tsvgm']}}, 10:25:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:25:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:25:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:25:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['damp', 'tps']}, 10:25:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'tests': ['damp', 'tps']}, 10:25:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['dromaeo_dom']}, 10:25:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['a11yr', 10:25:38 INFO - 'ts_paint', 10:25:38 INFO - 'tpaint', 10:25:38 INFO - 'sessionrestore', 10:25:38 INFO - 'sessionrestore_no_auto_restore', 10:25:38 INFO - 'tabpaint']}, 10:25:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['tsvgx', 10:25:38 INFO - 'tsvgr_opacity', 10:25:38 INFO - 'tart', 10:25:38 INFO - 'tscrollx', 10:25:38 INFO - 'cart']}, 10:25:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:25:38 INFO - 'tsvgr_opacity', 10:25:38 INFO - 'tart', 10:25:38 INFO - 'tscrollx', 10:25:38 INFO - 'cart']}, 10:25:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'talos_options': ['--disable-e10s'], 10:25:38 INFO - 'tests': ['tp5o']}, 10:25:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'tests': ['tp5o']}, 10:25:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'talos_options': ['--disable-e10s', 10:25:38 INFO - '--xperf_path', 10:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:38 INFO - 'tests': ['tp5n']}, 10:25:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:38 INFO - 'talos_options': ['--xperf_path', 10:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:38 INFO - 'tests': ['tp5n']}}, 10:25:38 INFO - 'talos.zip': {'path': '', 10:25:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:38 INFO - Running post-action listener: _resource_record_post_action 10:25:38 INFO - ##### 10:25:38 INFO - ##### Finished populate-webroot step (success) 10:25:38 INFO - ##### 10:25:38 INFO - ##### 10:25:38 INFO - ##### Running create-virtualenv step. 10:25:38 INFO - ##### 10:25:38 INFO - Running pre-action listener: _resource_record_pre_action 10:25:38 INFO - Running main action method: create_virtualenv 10:25:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:38 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 10:25:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:39 INFO - Using real prefix '/usr' 10:25:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:25:41 INFO - Installing pip.................done. 10:25:41 INFO - Return code: 0 10:25:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:41 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:41 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 10:25:41 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 10:25:41 INFO - Using env: {'DISPLAY': ':0', 10:25:41 INFO - 'HOME': '/home/cltbld', 10:25:41 INFO - 'LANG': 'en_US.UTF-8', 10:25:41 INFO - 'LANGUAGE': 'en_US:en', 10:25:41 INFO - 'LOGNAME': 'cltbld', 10:25:41 INFO - 'MAIL': '/var/mail/cltbld', 10:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:41 INFO - 'MOZ_NO_REMOTE': '1', 10:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:41 INFO - 'NO_EM_RESTART': '1', 10:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:41 INFO - 'PWD': '/builds/slave/test', 10:25:41 INFO - 'SHELL': '/bin/bash', 10:25:41 INFO - 'SHLVL': '1', 10:25:41 INFO - 'TERM': 'linux', 10:25:41 INFO - 'TMOUT': '86400', 10:25:41 INFO - 'USER': 'cltbld', 10:25:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:41 INFO - '_': '/tools/buildbot/bin/python'} 10:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:41 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 10:25:41 INFO - Cleaning up... 10:25:41 INFO - Return code: 0 10:25:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:41 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:41 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 10:25:41 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 10:25:41 INFO - Using env: {'DISPLAY': ':0', 10:25:41 INFO - 'HOME': '/home/cltbld', 10:25:41 INFO - 'LANG': 'en_US.UTF-8', 10:25:41 INFO - 'LANGUAGE': 'en_US:en', 10:25:41 INFO - 'LOGNAME': 'cltbld', 10:25:41 INFO - 'MAIL': '/var/mail/cltbld', 10:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:41 INFO - 'MOZ_NO_REMOTE': '1', 10:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:41 INFO - 'NO_EM_RESTART': '1', 10:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:41 INFO - 'PWD': '/builds/slave/test', 10:25:41 INFO - 'SHELL': '/bin/bash', 10:25:41 INFO - 'SHLVL': '1', 10:25:41 INFO - 'TERM': 'linux', 10:25:41 INFO - 'TMOUT': '86400', 10:25:41 INFO - 'USER': 'cltbld', 10:25:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:41 INFO - '_': '/tools/buildbot/bin/python'} 10:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:42 INFO - Downloading/unpacking psutil>=3.1.1 10:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:44 INFO - Installing collected packages: psutil 10:25:44 INFO - Running setup.py install for psutil 10:25:44 INFO - building 'psutil._psutil_linux' extension 10:25:44 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 10:25:44 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 10:25:44 INFO - building 'psutil._psutil_posix' extension 10:25:44 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 10:25:44 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 10:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:44 INFO - Successfully installed psutil 10:25:44 INFO - Cleaning up... 10:25:44 INFO - Return code: 0 10:25:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:44 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:44 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 10:25:44 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 10:25:44 INFO - Using env: {'DISPLAY': ':0', 10:25:44 INFO - 'HOME': '/home/cltbld', 10:25:44 INFO - 'LANG': 'en_US.UTF-8', 10:25:44 INFO - 'LANGUAGE': 'en_US:en', 10:25:44 INFO - 'LOGNAME': 'cltbld', 10:25:44 INFO - 'MAIL': '/var/mail/cltbld', 10:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:44 INFO - 'MOZ_NO_REMOTE': '1', 10:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:44 INFO - 'NO_EM_RESTART': '1', 10:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:44 INFO - 'PWD': '/builds/slave/test', 10:25:44 INFO - 'SHELL': '/bin/bash', 10:25:44 INFO - 'SHLVL': '1', 10:25:44 INFO - 'TERM': 'linux', 10:25:44 INFO - 'TMOUT': '86400', 10:25:44 INFO - 'USER': 'cltbld', 10:25:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:44 INFO - '_': '/tools/buildbot/bin/python'} 10:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:25:46 INFO - Installing collected packages: mozsystemmonitor 10:25:46 INFO - Running setup.py install for mozsystemmonitor 10:25:46 INFO - Successfully installed mozsystemmonitor 10:25:46 INFO - Cleaning up... 10:25:46 INFO - Return code: 0 10:25:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:25:46 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')]} 10:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:46 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')]} 10:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:46 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:46 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 10:25:46 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 10:25:46 INFO - Using env: {'DISPLAY': ':0', 10:25:46 INFO - 'HOME': '/home/cltbld', 10:25:46 INFO - 'LANG': 'en_US.UTF-8', 10:25:46 INFO - 'LANGUAGE': 'en_US:en', 10:25:46 INFO - 'LOGNAME': 'cltbld', 10:25:46 INFO - 'MAIL': '/var/mail/cltbld', 10:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:46 INFO - 'MOZ_NO_REMOTE': '1', 10:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:46 INFO - 'NO_EM_RESTART': '1', 10:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:46 INFO - 'PWD': '/builds/slave/test', 10:25:46 INFO - 'SHELL': '/bin/bash', 10:25:46 INFO - 'SHLVL': '1', 10:25:46 INFO - 'TERM': 'linux', 10:25:46 INFO - 'TMOUT': '86400', 10:25:46 INFO - 'USER': 'cltbld', 10:25:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:46 INFO - '_': '/tools/buildbot/bin/python'} 10:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:25:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:25:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:49 INFO - Downloading docopt-0.6.1.tar.gz 10:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:25:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:25:49 INFO - Running setup.py install for blobuploader 10:25:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:25:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:25:49 INFO - Running setup.py install for requests 10:25:50 INFO - Running setup.py install for docopt 10:25:50 INFO - Successfully installed blobuploader requests docopt 10:25:50 INFO - Cleaning up... 10:25:50 INFO - Return code: 0 10:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:50 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')]} 10:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 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')]} 10:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:50 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:50 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 10:25:50 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 10:25:50 INFO - Using env: {'DISPLAY': ':0', 10:25:50 INFO - 'HOME': '/home/cltbld', 10:25:50 INFO - 'LANG': 'en_US.UTF-8', 10:25:50 INFO - 'LANGUAGE': 'en_US:en', 10:25:50 INFO - 'LOGNAME': 'cltbld', 10:25:50 INFO - 'MAIL': '/var/mail/cltbld', 10:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:50 INFO - 'MOZ_NO_REMOTE': '1', 10:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:50 INFO - 'NO_EM_RESTART': '1', 10:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:50 INFO - 'PWD': '/builds/slave/test', 10:25:50 INFO - 'SHELL': '/bin/bash', 10:25:50 INFO - 'SHLVL': '1', 10:25:50 INFO - 'TERM': 'linux', 10:25:50 INFO - 'TMOUT': '86400', 10:25:50 INFO - 'USER': 'cltbld', 10:25:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:50 INFO - '_': '/tools/buildbot/bin/python'} 10:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:50 INFO - Running setup.py (path:/tmp/pip-9cLt4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:50 INFO - Running setup.py (path:/tmp/pip-eZVH4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:50 INFO - Running setup.py (path:/tmp/pip-JxonIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:50 INFO - Running setup.py (path:/tmp/pip-ZxUjoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:50 INFO - Running setup.py (path:/tmp/pip-RePh55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:50 INFO - Running setup.py (path:/tmp/pip-J4n2GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:50 INFO - Running setup.py (path:/tmp/pip-_efyHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:51 INFO - Running setup.py (path:/tmp/pip-NFyGbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:51 INFO - Running setup.py (path:/tmp/pip-bEu1us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:51 INFO - Running setup.py (path:/tmp/pip-s02NJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:51 INFO - Running setup.py (path:/tmp/pip-Zx2i1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:51 INFO - Running setup.py (path:/tmp/pip-PlIDJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:51 INFO - Running setup.py (path:/tmp/pip-gnRRC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:51 INFO - Running setup.py (path:/tmp/pip-efm9Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:51 INFO - Running setup.py (path:/tmp/pip-tDYD9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:51 INFO - Running setup.py (path:/tmp/pip-U7swzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:51 INFO - Running setup.py (path:/tmp/pip-BhobvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:25:51 INFO - Running setup.py install for manifestparser 10:25:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:25:51 INFO - Running setup.py install for mozcrash 10:25:51 INFO - Running setup.py install for mozdebug 10:25:52 INFO - Running setup.py install for mozdevice 10:25:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for mozfile 10:25:52 INFO - Running setup.py install for mozhttpd 10:25:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for mozinfo 10:25:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for mozInstall 10:25:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for mozleak 10:25:52 INFO - Running setup.py install for mozlog 10:25:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for moznetwork 10:25:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:25:52 INFO - Running setup.py install for mozprocess 10:25:53 INFO - Running setup.py install for mozprofile 10:25:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:25:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:25:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:25:53 INFO - Running setup.py install for mozrunner 10:25:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:25:53 INFO - Running setup.py install for mozscreenshot 10:25:53 INFO - Running setup.py install for moztest 10:25:53 INFO - Running setup.py install for mozversion 10:25:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:25:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:25:53 INFO - Cleaning up... 10:25:53 INFO - Return code: 0 10:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:53 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:53 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 10:25:53 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 10:25:53 INFO - Using env: {'DISPLAY': ':0', 10:25:53 INFO - 'HOME': '/home/cltbld', 10:25:53 INFO - 'LANG': 'en_US.UTF-8', 10:25:53 INFO - 'LANGUAGE': 'en_US:en', 10:25:53 INFO - 'LOGNAME': 'cltbld', 10:25:53 INFO - 'MAIL': '/var/mail/cltbld', 10:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:53 INFO - 'MOZ_NO_REMOTE': '1', 10:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:53 INFO - 'NO_EM_RESTART': '1', 10:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:53 INFO - 'PWD': '/builds/slave/test', 10:25:53 INFO - 'SHELL': '/bin/bash', 10:25:53 INFO - 'SHLVL': '1', 10:25:53 INFO - 'TERM': 'linux', 10:25:53 INFO - 'TMOUT': '86400', 10:25:53 INFO - 'USER': 'cltbld', 10:25:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:53 INFO - '_': '/tools/buildbot/bin/python'} 10:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:53 INFO - Running setup.py (path:/tmp/pip-4I1CcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:53 INFO - Running setup.py (path:/tmp/pip-DOKrPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:53 INFO - Running setup.py (path:/tmp/pip-aT27LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:54 INFO - Running setup.py (path:/tmp/pip-q73mgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:54 INFO - Running setup.py (path:/tmp/pip-chuKHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:54 INFO - Running setup.py (path:/tmp/pip-CQeFkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:54 INFO - Running setup.py (path:/tmp/pip-7xAAYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:54 INFO - Running setup.py (path:/tmp/pip-qSSkZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:54 INFO - Running setup.py (path:/tmp/pip-V2M6zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:54 INFO - Running setup.py (path:/tmp/pip-w2gX98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:54 INFO - Running setup.py (path:/tmp/pip-85TBla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:54 INFO - Running setup.py (path:/tmp/pip-q67Bdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:54 INFO - Running setup.py (path:/tmp/pip-EWJUr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:54 INFO - Running setup.py (path:/tmp/pip-2PqTPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:54 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)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:54 INFO - Running setup.py (path:/tmp/pip-gbbTfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:54 INFO - Running setup.py (path:/tmp/pip-ioQRGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:54 INFO - Running setup.py (path:/tmp/pip-ERU_z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:55 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)) 10:25:55 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)) 10:25:55 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)) 10:25:55 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)) 10:25:55 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)) 10:25:55 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)) 10:25:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:56 INFO - Downloading blessings-1.6.tar.gz 10:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:25:56 INFO - Installing collected packages: blessings 10:25:56 INFO - Running setup.py install for blessings 10:25:57 INFO - Successfully installed blessings 10:25:57 INFO - Cleaning up... 10:25:57 INFO - Return code: 0 10:25:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:57 INFO - Reading from file tmpfile_stdout 10:25:57 INFO - Current package versions: 10:25:57 INFO - argparse == 1.2.1 10:25:57 INFO - blessings == 1.6 10:25:57 INFO - blobuploader == 1.2.4 10:25:57 INFO - docopt == 0.6.1 10:25:57 INFO - manifestparser == 1.1 10:25:57 INFO - mozInstall == 1.12 10:25:57 INFO - mozcrash == 0.17 10:25:57 INFO - mozdebug == 0.1 10:25:57 INFO - mozdevice == 0.48 10:25:57 INFO - mozfile == 1.2 10:25:57 INFO - mozhttpd == 0.7 10:25:57 INFO - mozinfo == 0.9 10:25:57 INFO - mozleak == 0.1 10:25:57 INFO - mozlog == 3.2 10:25:57 INFO - moznetwork == 0.27 10:25:57 INFO - mozprocess == 0.22 10:25:57 INFO - mozprofile == 0.28 10:25:57 INFO - mozrunner == 6.11 10:25:57 INFO - mozscreenshot == 0.1 10:25:57 INFO - mozsystemmonitor == 0.3 10:25:57 INFO - moztest == 0.7 10:25:57 INFO - mozversion == 1.4 10:25:57 INFO - psutil == 3.1.1 10:25:57 INFO - requests == 1.2.3 10:25:57 INFO - wsgiref == 0.1.2 10:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:57 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')]} 10:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:57 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')]} 10:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:57 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:57 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 10:25:57 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 10:25:57 INFO - Using env: {'DISPLAY': ':0', 10:25:57 INFO - 'HOME': '/home/cltbld', 10:25:57 INFO - 'LANG': 'en_US.UTF-8', 10:25:57 INFO - 'LANGUAGE': 'en_US:en', 10:25:57 INFO - 'LOGNAME': 'cltbld', 10:25:57 INFO - 'MAIL': '/var/mail/cltbld', 10:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:57 INFO - 'MOZ_NO_REMOTE': '1', 10:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:57 INFO - 'NO_EM_RESTART': '1', 10:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:57 INFO - 'PWD': '/builds/slave/test', 10:25:57 INFO - 'SHELL': '/bin/bash', 10:25:57 INFO - 'SHLVL': '1', 10:25:57 INFO - 'TERM': 'linux', 10:25:57 INFO - 'TMOUT': '86400', 10:25:57 INFO - 'USER': 'cltbld', 10:25:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:57 INFO - '_': '/tools/buildbot/bin/python'} 10:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 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)) 10:25:57 INFO - Cleaning up... 10:25:57 INFO - Return code: 0 10:25:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:25:57 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')]} 10:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:57 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')]} 10:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:57 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:25:57 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 10:25:57 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 10:25:57 INFO - Using env: {'DISPLAY': ':0', 10:25:57 INFO - 'HOME': '/home/cltbld', 10:25:57 INFO - 'LANG': 'en_US.UTF-8', 10:25:57 INFO - 'LANGUAGE': 'en_US:en', 10:25:57 INFO - 'LOGNAME': 'cltbld', 10:25:57 INFO - 'MAIL': '/var/mail/cltbld', 10:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:57 INFO - 'MOZ_NO_REMOTE': '1', 10:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:57 INFO - 'NO_EM_RESTART': '1', 10:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:57 INFO - 'PWD': '/builds/slave/test', 10:25:57 INFO - 'SHELL': '/bin/bash', 10:25:57 INFO - 'SHLVL': '1', 10:25:57 INFO - 'TERM': 'linux', 10:25:57 INFO - 'TMOUT': '86400', 10:25:57 INFO - 'USER': 'cltbld', 10:25:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:57 INFO - '_': '/tools/buildbot/bin/python'} 10:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:57 INFO - Downloading/unpacking jsonschema 10:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:25:59 INFO - Downloading/unpacking functools32 (from jsonschema) 10:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:25:59 INFO - warning: no files found matching '*.txt' 10:25:59 INFO - no previously-included directories found matching 'build' 10:25:59 INFO - no previously-included directories found matching 'dist' 10:25:59 INFO - no previously-included directories found matching '.git*' 10:25:59 INFO - Installing collected packages: jsonschema, functools32 10:25:59 INFO - Running setup.py install for functools32 10:26:00 INFO - warning: no files found matching '*.txt' 10:26:00 INFO - no previously-included directories found matching 'build' 10:26:00 INFO - no previously-included directories found matching 'dist' 10:26:00 INFO - no previously-included directories found matching '.git*' 10:26:00 INFO - Successfully installed jsonschema functools32 10:26:00 INFO - Cleaning up... 10:26:00 INFO - Return code: 0 10:26:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:26:00 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')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:00 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')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:00 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 0x7fbb482eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1664770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', '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 10:26:00 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 10:26:00 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 10:26:00 INFO - Using env: {'DISPLAY': ':0', 10:26:00 INFO - 'HOME': '/home/cltbld', 10:26:00 INFO - 'LANG': 'en_US.UTF-8', 10:26:00 INFO - 'LANGUAGE': 'en_US:en', 10:26:00 INFO - 'LOGNAME': 'cltbld', 10:26:00 INFO - 'MAIL': '/var/mail/cltbld', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:00 INFO - 'PWD': '/builds/slave/test', 10:26:00 INFO - 'SHELL': '/bin/bash', 10:26:00 INFO - 'SHLVL': '1', 10:26:00 INFO - 'TERM': 'linux', 10:26:00 INFO - 'TMOUT': '86400', 10:26:00 INFO - 'USER': 'cltbld', 10:26:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:00 INFO - '_': '/tools/buildbot/bin/python'} 10:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:00 INFO - Downloading/unpacking flake8 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:26:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:26:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 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 10:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:26:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:26:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:26:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:26:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:26:02 INFO - no previously-included directories found matching 'docs/_build' 10:26:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:26:03 INFO - Running setup.py install for pep8 10:26:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:26:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:26:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:26:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:26:03 INFO - no previously-included directories found matching 'docs/_build' 10:26:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:26:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:26:03 INFO - Cleaning up... 10:26:03 INFO - Return code: 0 10:26:03 INFO - Running post-action listener: _resource_record_post_action 10:26:03 INFO - Running post-action listener: _start_resource_monitoring 10:26:03 INFO - Starting resource monitoring. 10:26:03 INFO - ##### 10:26:03 INFO - ##### Finished create-virtualenv step (success) 10:26:03 INFO - ##### 10:26:03 INFO - ##### 10:26:03 INFO - ##### Running install step. 10:26:03 INFO - ##### 10:26:03 INFO - Running pre-action listener: _resource_record_pre_action 10:26:03 INFO - Running main action method: install 10:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:03 INFO - Reading from file tmpfile_stdout 10:26:03 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:03 INFO - Reading from file tmpfile_stdout 10:26:03 INFO - Output received: 10:26:03 INFO - Usage: mozinstall [options] installer 10:26:03 INFO - Options: 10:26:03 INFO - -h, --help show this help message and exit 10:26:03 INFO - -d DEST, --destination=DEST 10:26:03 INFO - Directory to install application into. [default: 10:26:03 INFO - "/builds/slave/test"] 10:26:03 INFO - --app=APP Application being installed. [default: firefox] 10:26:03 INFO - mkdir: /builds/slave/test/build/application 10:26:03 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'] 10:26:03 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 10:26:20 INFO - Reading from file tmpfile_stdout 10:26:20 INFO - Output received: 10:26:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:26:20 INFO - Running post-action listener: _resource_record_post_action 10:26:20 INFO - ##### 10:26:20 INFO - ##### Finished install step (success) 10:26:20 INFO - ##### 10:26:20 INFO - ##### 10:26:20 INFO - ##### Running run-tests step. 10:26:20 INFO - ##### 10:26:20 INFO - Running pre-action listener: _resource_record_pre_action 10:26:20 INFO - Running main action method: run_tests 10:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:26:20 INFO - Python 2.7.3 10:26:20 INFO - Return code: 0 10:26:20 INFO - grabbing minidump binary from tooltool 10:26: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')]} 10:26:20 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 0x16f39c0>, '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 0x16f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:26:20 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 10:26:20 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 10:26:20 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 10:26:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:26:20 INFO - Return code: 0 10:26:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:26:21 INFO - Return code: 0 10:26:21 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/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 10:26:21 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/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 10:26:21 INFO - Using env: {'DISPLAY': ':0', 10:26:21 INFO - 'HOME': '/home/cltbld', 10:26:21 INFO - 'LANG': 'en_US.UTF-8', 10:26:21 INFO - 'LANGUAGE': 'en_US:en', 10:26:21 INFO - 'LOGNAME': 'cltbld', 10:26:21 INFO - 'MAIL': '/var/mail/cltbld', 10:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:21 INFO - 'MOZ_NO_REMOTE': '1', 10:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:21 INFO - 'NO_EM_RESTART': '1', 10:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:21 INFO - 'PWD': '/builds/slave/test', 10:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:26:21 INFO - 'SHELL': '/bin/bash', 10:26:21 INFO - 'SHLVL': '1', 10:26:21 INFO - 'TERM': 'linux', 10:26:21 INFO - 'TMOUT': '86400', 10:26:21 INFO - 'USER': 'cltbld', 10:26:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023', 10:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:21 INFO - '_': '/tools/buildbot/bin/python'} 10:26:21 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/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 10:26:21 INFO - mozversion application_buildid: 20160524073714 10:26:21 INFO - mozversion application_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 10:26:21 INFO - mozversion application_display_name: Nightly 10:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:21 INFO - mozversion application_name: Firefox 10:26:21 INFO - mozversion application_remotingname: firefox 10:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:26:21 INFO - mozversion application_vendor: Mozilla 10:26:21 INFO - mozversion application_version: 49.0a1 10:26:21 INFO - mozversion platform_buildid: 20160524073714 10:26:21 INFO - mozversion platform_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 10:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:26:21 INFO - mozversion platform_version: 49.0a1 10:26:21 INFO - using testdate: 1464110781 10:26:21 INFO - actual date: 1464110781 10:26:21 INFO - starting webserver on 'localhost:52695' 10:26:21 INFO - SUITE-START | Running 2 tests 10:26:21 INFO - TEST-START | dromaeo_css 10:26:21 INFO - operating with platform_type : linux_ 10:26:21 INFO - Initialising browser for dromaeo_css test... 10:26:21 INFO - TEST-INFO | started process 3251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqVvGI/profile http://localhost:52695/getInfo.html) 10:26:25 INFO - PROCESS | 3251 | __metrics Screen width/height:1600/1200 10:26:25 INFO - PROCESS | 3251 | colorDepth:24 10:26:25 INFO - PROCESS | 3251 | Browser inner width/height: 1024/697 10:26:25 INFO - PROCESS | 3251 | __metrics 10:26:26 ERROR - PROCESS | 3251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:26:27 INFO - TEST-INFO | 3251: exit 0 10:26:27 INFO - Browser initialized. 10:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:26:27 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqVvGI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:39 INFO - PROCESS | 3333 | RSS: Main: 153366528 10:26:39 INFO - PROCESS | 3333 | 10:27:30 INFO - PROCESS | 3333 | 1464110850638 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] 10:29:38 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52695/tests/dromaeo/cssquery-ext.html) 10:29:39 INFO - PROCESS | 3333 | RSS: Main: 251469824 10:29:39 INFO - PROCESS | 3333 | 10:32:41 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-ext.html (next: http://localhost:52695/tests/dromaeo/cssquery-jquery.html) 10:32:42 INFO - PROCESS | 3333 | RSS: Main: 236032000 10:32:42 INFO - PROCESS | 3333 | 10:35:44 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52695/tests/dromaeo/cssquery-mootools.html) 10:35:44 INFO - PROCESS | 3333 | RSS: Main: 235356160 10:35:44 INFO - PROCESS | 3333 | 10:38:46 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52695/tests/dromaeo/cssquery-prototype.html) 10:38:47 INFO - PROCESS | 3333 | RSS: Main: 236453888 10:38:47 INFO - PROCESS | 3333 | 10:41:50 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52695/tests/dromaeo/cssquery-yui.html) 10:41:50 INFO - PROCESS | 3333 | RSS: Main: 219148288 10:41:50 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | Cycle 1(1): loaded http://localhost:52695/tests/dromaeo/cssquery-yui.html (next: http://localhost:52695/tests/dromaeo/cssquery-dojo.html) 10:44:53 INFO - PROCESS | 3333 | RSS: Main: 267517952 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | __start_tp_report 10:44:53 INFO - PROCESS | 3333 | _x_x_mozilla_page_load 10:44:53 INFO - PROCESS | 3333 | _x_x_mozilla_page_load_details 10:44:53 INFO - PROCESS | 3333 | |i|pagename|runs| 10:44:53 INFO - PROCESS | 3333 | |0;dojo.html;3175.4284228838806;3187.9521807172882;3204.3431096625186;3222.661620529843;3247.6102867655886;5326.121190003654;5388.703621300827;5479.4794494523;5506.917396239055;5598.748056337465;5465.480779325968;5499.670019798805;5505;5524.8342549723475;5567.248421463101;4933.309336692866;4985.925211121836;5018.2974383586325;5028.195488721805;5131.307273518065;5032.4212715537815;5046.369203849519;5064.746762661871;5070.923936140943;5089.949100509003;4918.311436398907;4976.203807390818;4976.776045077981;4980.850574482772;5009.398872135331;4959.677620954626;4974.602031837444;5033.0688822567945;5049.166887463564;5066.898662026776;4889.804407823683;4971.850844474671;5014.423341315759;5024.924626130611;5065;5274.868128296785;5352.384475785296;5363.436839131913;5396.43337449566;5405.108157154064;5768;5814.098814683731;5844.1818145459665;5851.502622277111;5872.412758724136;5619.719014049322;5850.736716847752;5992.161097446361;6021.939780602225;6027.216461859974;5475.178723191553;5489.560835133179;5536.058869992071;5543.1408131739645;5565.666060036411;6046.356727093757;6048.818535443944;6069.302030266487;6076.696165191723;6087.239095113111;5622.606417550732;5763.106718458645;5807.767689292381;5810.331811841692;5857.414258574194;5929.851753706192;5930.021546444875;5932.2584676915385;5932.3474417814;5972.910406343908;5873.530117590582;5909.852253693606;5923;5925.081612350093;5930.644161350333;5690.089585666274;5852.882942341129;5900.1739756434135;5905.291365036223;5915;4490.550944905549;4493.483249426358;4494.752788596658;4495.123450927038;4531.13908357411;3976.6421022108148;4003.779792111462;4012.217617564547;4039.0104424415617;4066.9832541864535;5442.156465747816;5476.315460567429;5478.342598888079;5492.313460817398;5500.724963751796;5848.152017957373;5865.237519122486;5889.263842019747;5898.203742494708;5945.464908158287;5492.642978206404;5499.972500137474;5502.8349149525575;5505.064139096363;5505.642133261325;4947.802087916443;5027.044861476308;5036.722980236123;5055.671381360274;5061.038402703474;6062.666553339609;6078.149059131725;6078.392160783975;6086.239220097488;6086.908696369558;5831.708414579339;5883.0881213411985;5885.705714714333;5888.352281248974;5895.263092113486;5964.343922168645;6091.511430256314;6099.794059995639;6100.694965251809;6159.260888693386;5803.651780892991;5863.853403664943;5865.589408741347;5876.911846322394;5905.43898329658;5797.623154494944;5911.881762364643;5920.052791553331;5926.407359264212;5930.733117009831;5767.365589785204;5825.76696932118;5836.358000620014;5842.678652673973;5851.034579294369;5795.39148389413;5826.533877289891;5826.796062137805;5829.59192856496;5833.562482813721;5562.110062389998;5636.887262254814;5642.153676948326;5657.3776884543495;5679.233303504139;5825.650460972355;5870.530357571299;5873.2658417697785;5877.706114694333;5901.232839730979;5722.885542289214;5724.026915424472;5726;5730.054541000855;5744.4829965303325 10:44:53 INFO - PROCESS | 3333 | |1;ext.html;581.1921429213394;628.1551313483365;642.8103709405725;648.3905129178572;657.9736810527579;31573.526397104033;34876.12809679759;34889.651103488955;43067.56932430675;44176.77911610445;43825.34261986065;43924.341134883005;44146;44203.77898110513;44219.89450263745;8655.0912154224;8844.646214151426;8849.734507964771;8856.202941735275;8865.911340886572;8671.739847804576;8754.606042728092;8798.736037918841;8801.119888011179;8818.603162857655;8785.428947118417;8856.114388561125;8858.29133669305;8874.290056795473;8882.022977472505;8653.177948094952;8729.08344623818;8732.563371831384;8733.912660873406;8742.781430464225;8680.08859069795;8765.079666634976;8772.824543509094;8777.64889404423;8780.078091800333;41384.79307603473;41816.790916045225;41881;41907.79046104781;41910;3353.295807880348;3458.360203362361;3593.568771747407;3981.7212795104356;3985.163115745697;31087.222819429695;31454.213644658837;31631;31691.524627130613;32451.02646920596;4282.657387409;4312.482502099768;4328.956710432887;4331.5884990925815;4481.103779244164;341818;342950;343427;344076;346013.26993365126;50109.74945125251;55190.448095519336;56382.15426768602;56450.71774641183;56959.43040569541;54873.45126548763;54980.72509637506;55120;56498.71750641303;56504.71747641318;15915.204239787965;16055.518334449986;16095.356185752673;16119.435819746253;16156;12533.561325353568;12620.684482888002;12633.557825476064;12644.304563248925;12793.360331983364;15796.526104216891;15823.762643560356;15906.76139857903;15919.602009949844;15937.681246375008;6287.717052732638;6446.903296450557;6532.248791389051;6603.537752357385;6610.900836487456;1038.309524166421;1079.9028087472166;1089.057964860406;1165.2542372881362;1197.2277880766856;32157.196070097965;32286.19284517906;32501.837490812395;32718.509222361685;33099;935.3826474526779;1132.903703185222;1158.8725240223569;1223.2049168040667;1227;17055.829441705424;17283.827161728474;17312.480625581;17353.913230433765;17418.47744567665;467620;472433;472907;475260;475769;57264.42735572591;57322.140167897516;57352;57395.13907291394;57418;1266.2845492296822;1321.4119716726157;1327.2368388176837;1342.2282187741891;1360.4626172661742;30678.693213068476;34186;34583.65416345804;34827.55004718866;34859.128521787155;50244.497555025446;51064.48935510597;51184.23223651723;51215.743921280155;51256.74371628118;455280;458173;458178;460314;462857;38148.427773582865;43710.34434483549;43987.34018989782;44542.331865021406;45514.544854552354;48466.51533484761;48725;49091.75454122706;49627.75186124046;50293;40241.1951760969;40309.1938161241;40342.59657403389;41866.79066604647;42227.36658950057;41134;41156.58843411528;41365.58634413738;41408.58591414047;41886.79056604819;40585;41470.79264603658;41648.375274371516;41993.58006420019;42201.577984219766;33919.321613568085;36224;36618;36839.44740828943;36855.44716829303;28174.2956426091;28248.43503129967;28328.85835570809;28490;28575.714242857306 10:44:53 INFO - PROCESS | 3333 | |2;jquery.html;396.4370593756866;397.8687033279018;404.3792778085639;411.3788179848429;422.12830505007156;12838.48646054159;18215;19631;19692.704609430853;19716.112774925146;18664.16011279492;18761.061946902635;19570.11934462949;19692.606147877068;19732.730735965368;5547.750351234194;5693.516051135658;5731.254936858202;5738.684372359518;5746;5597.3003374578175;5673.404292549285;5674.687892165929;5688.772449102052;5697.487226149646;4127.855525056623;6060.575759696823;6374.203224596926;6379.617222966637;6515.739370425201;5413.729313534347;5732.713364331767;6441.967790161019;6482.773102941374;6497.545171837974;5610.747516361774;5620.128880023562;5628.577856660767;5636.436356364372;5639.68981706006;13295.202287862663;15998.200089995453;20556.897215513975;23506.529869402515;23531.058757649673;2297.1615360393503;2346.601077816775;2647.3116989582654;2887.985560072186;2958.393529326483;9088.227500662451;9862.063104005108;10118.595256189743;11556.94221528887;14188.716225675533;1878.8684792064562;1884.3498992847447;1895.8388536974373;1901.7622797150357;1999.8900060496667;73974;80807;82454.58772706157;82612;85264;10798.406087665096;10870.891291087146;10992.29619408993;11041.944790275997;11212.159088068427;15560.688786224213;15618.531444056696;15636.609084772972;15645.687086258211;15647;7831.686732530635;7987.281144697005;8029.4379393441895;8172.509649421054;8202;7772.727954521678;7822.217778222246;7830.412719046094;7949.841003179904;7981.600919953979;4518.480374756945;4538.11506756186;4541.863744087683;4619.95380046202;4832.106060378771;1902.5243689077731;1929.4211736479;1940.417874637603;1956.6380219659409;1986.5828176082896;994.9353292035994;1010.4644538394663;1022.539857064324;1032.7727899862018;1103.365564800243;18206.271749130152;18946.715799263024;19207.51981200481;19289.9479135486;19434;971.640493017588;979.8775153105862;986.7779749556292;996.2577879479834;1033.039273475675;10607.522661480252;10874.156033431593;10936.453177341102;10983.670489885317;11008.834867476995;417413;432885;449134;450487;456593;66153.00770488447;95406;96096;98233;98649.50675246578;997.4563862694848;1003.7841863999275;1005.2058873490007;1010.2372708604956;1040.6201736366322;16532.008079514788;16896;16983.745243821104;17055.403060892808;17497.650046999242;41693.79153104215;41774;42781.78609106935;42801;43362.13275734404;53935.46064539461;54095;56100;57974.13038804506;63225;7842.725504607311;8174.141715119827;8185.386096042702;8331.50010999342;8491.830163396575;11149.94425027902;12675.746485070431;13430.39563219638;13684.110532815335;14054.578362649137;11369.2609980351;11698;11753;11891.702707432038;11999.100067495147;8542.82914341722;11595.536178552764;11615.941920290345;11768.411579420823;11851.111166662362;11742.471588778355;11760.529578816751;11769.529218831492;11798.056155507711;11887.108466865193;8022.799430014296;8119;8204.958975205085;8218.589070546568;8528.914710852812;8369.49783013021;9873.703788886345;10652.946735266274;11648.41757912084;11655.825162622397 10:44:53 INFO - PROCESS | 3333 | |3;mootools.html;1363.6659018540447;1462.7805829125632;1516.7573188289873;1645.432325847583;1810.7012342963403;8171.673133074677;8437.746867593982;8442.28240599549;8444.788880277996;8678.39251252411;8108.351331893449;8379.120192379789;8584.184502472272;8592.26965707914;8592.828143437127;1999.940001799941;2230.531588366437;2246.4608493961414;2282.269673704407;2311.3297143828268;2340.9414764630937;2346.1319311854636;2346.601077816775;2348.9530209395803;2349.083857295656;2259.186692790594;2263.1173842201474;2298.678185054094;2306.630939049752;2308.4459729664927;1934.8839069655867;2180.465785882469;2239.3505883293824;2247.6740872573387;2256.2103263857684;2294.025039358266;2299.1608063056865;2306.3542208181734;2311.0755697721047;2312.5490529346785;8569.828603427959;8611.526366049864;8621.310295176434;8631.65473381064;8652.351073669437;5062.670926389773;5218.217267409919;5242.6330156889035;5244.79020839166;5257.369115706101;3251.089694885436;3317.170707323169;3362.411577973845;3384.4077286475012;3388.1190890368434;1121.506537123663;1121.775644871029;1135.5571327182406;1137.243732917609;1152.8674202466657;11576.53693852245;11681.649550513413;11742.001929835975;11772.058235341237;11773;4595.241785105487;4670.322803193586;4769.332293478916;4771.642126840501;4782.832600859023;10532.526036328383;10546.156307495383;10552.788944221073;10554.050135487843;10561.049505544537;5222.033923724123;5228.503292187236;5229.320188375563;5232.136697444955;5234.947650523446;4291.163223171452;4734.171519983989;4886.169351210303;4891.461939186686;4932.4081110267;4055.398117743534;4117.629413352813;4156.594511150921;4184.853530126492;4196.685248606367;1265.8038004109378;1273.6688461000022;1280.6542233596876;1287.5493577248076;1301.342821874966;1014.9188064954786;1039.4958445154093;1045.3153184664056;1045.3205416479198;1052.1004541117388;6120.908186377208;6203.96898015507;6223.906641400383;6304.936950630527;6320.336364681734;450.3964687319008;450.5517010574499;450.70929250633156;455.153414648753;460.8456167184031;4255.446791917031;4281.828726850953;4298.63461605767;4406.889827754332;4412.33814927757;10810.67567972962;11005.17461190414;11130.554777808797;11132.332060076422;11161.553537858557;10962.342259464458;10981.066609338135;11039;11058.944705276583;11066.059384952208;7849.686012559548;8165.673373065011;8343.749687509384;8405.747827565183;8442.57787110642;6198.473129784019;6270.9372906270355;6286.6856657166045;6338.239411270677;6434.002729576923;9915.801683966136;10240.846387304047;10342.069213770797;10352.430616316175;10392.220583456423;10224.335418197794;10308.96910308963;10443.321184123008;10453.738656533344;10541.947290263806;7039.225685174524;7526.473146879885;7689.077310722749;7691.653875575501;7815.726449574465;8819.823603528022;8853.911460885309;8930.464172149692;8930.508822014852;8935.419197752126;7768.417368697484;7819.178986206366;7835.451518393657;8054.37925148924;8148.185181481805;7778.455508114378;7813.882791758015;7892.447528672938;7914.366850652049;7970.322522585645;7245.311695388929;7300.525465844916;7352.963235184004;7378.114626244885;7382.704691812482;5441.646292990943;5491.176323551499;5568.192612071308;5580;5653.915191272052;5455.727213639381;5568.832935011957;5591.608587399006;5661.264035675335;5679.6024278301775 10:44:53 INFO - PROCESS | 3333 | |4;prototype.html;329.00911938189756;340.60489831795115;344.33371426290114;345.7752460900416;348.2286734882236;5306.097963346231;5318.601104917132;5342.358916929969;5357.785688572458;5411.323584551931;5054.393472783262;5095;5166.354205724285;5187.6628019178725;5325.920111198326;4122.196171746511;4157.8544750933725;4178.8328466861285;4192;4195.056112374707;4182.6862985276075;4195.538490766014;4198.895027624303;4207.600277973587;4222.134462435193;4000.7595746381976;4012.1975604878994;4136.110736191718;4140.81366338514;4145.917081658365;4130.876073717794;4138.358554424069;4144.896377590554;4166.312558427856;4173.749575025508;3718.9029236375336;3724.7392682512236;3734.6638802507905;3742;3747.64397382251;4964.702117872939;4967.528084831935;5101.7194054327;5103.9234411483485;5187.507186817246;4763.023580166057;4770.165221086296;4779.880502987418;4783.612752301829;4812.25410061441;5462.863428414282;5465.180222966547;5468.031508656881;5473.2063850741415;5525.922445123203;3901;4042.898927526806;4052.9392059119136;4052.9392059119136;4053.5541090480024;5576.414476479992;5661.348944871352;5667.943320566824;5701.401352857932;5709.229254050691;4116.711830171859;4128.587141285908;4151.398047283127;4161.854335098317;4166;4101.692373072032;4154.480689913761;4162;4202.684798640114;4218.878030257649;4691.39011928454;4698.389209402756;4705.023889966223;4718.197906355927;4722.858314250578;5479.698616576047;5518.475744804237;5561.360443548962;5582.888342233214;5586.525145362609;1374.7250549890061;1430.5636780781754;1438.841727409984;1454.1565891782952;1478.0835881753383;1002.5588740953957;1020.7907378987289;1028.1055481730941;1033.3748082410034;1037.455335948633;5202.557782588522;5203.687778733288;5206;5289.2859463972645;5317.8404647860625;5613.214150019001;5624.71876406178;5635.154726791015;5637.887242255132;5642.956053130184;5062.822801202014;5247.790088396498;5269.736513174326;5281.603879709037;5285.788568457296;2969.0107627889365;2974.182099922495;2985.9701402986125;2987.4323878463024;3005.128512731327;5636.408177141423;5681.772729090872;5747.683877386784;5810.360860305363;5816.2148110005455;5520.282363292827;5693.28833895763;5710.857228569236;5777.595568310262;5781.306243250837;5757.971210143923;5773;5825.679587622722;5875.206847075676;5891.351951285355;5561.499465048003;5709.030384517335;5719.283340413437;5728.455796699307;5740.13897915316;5540.171743324774;5575.637583557056;5652.434756524314;5671.234383358359;5677.886442271214;5801.738921748447;5803.82588522345;5818.156367326629;5831.329397119216;5871.970640146943;3973.4437178794415;4038.6970977176243;4053.70281509914;4056.1887622476215;4067.8372865085066;5674.432556744293;5676.659400435987;5708.857278568069;5713.028785106459;5756.1941328214925;5319.308489896289;5391.29913111293;5511.724413779375;5525.392206857323;5528.170774383714;5441.29263195782;5442.605253688364;5443.156310771837;5498.257735205696;5502.138887778253;5210.25456472071;5369.758360873692;5374.086405311028;5420.376656684374;5432.8047829477455;5504.651360416724;5518.53092487127;5525.226468294361;5538.723063846872;5551.8889622206525;5408.621396502207;5422.078246697992;5425.403205647454;5440.891182176413;5451.591130665295 10:44:53 INFO - PROCESS | 3333 | |5;yui.html;712.6579241963857;749.243264303054;750.8685979953507;772.675476299954;799.7480793550035;14032.15807051575;14532.200728959902;14538.781918271234;15053.247337633102;15107.773383399257;13550.254735989542;13674.316284185776;13680.179189248653;13687.110337828035;13694.178349299023;681.3629256645053;782.5422128055095;791.9920800791976;801.2708435323857;814.238686827815;817.7710241132493;820.2084987986592;820.7578764264556;824.3981893217955;827.1728271728272;864.0668078475231;865.1262225152578;865.8528050231445;866.4324867211986;866.7269810009826;710.683745733149;828.7555171224473;840.0129847429246;840.4201101240125;861.9525926074064;620.3734228429274;623.4607064888884;624.3350831364628;624.5815303746501;624.9968750156265;11869.169158158933;11898.583549575724;11911.285322880569;11923.642290731292;11986.70033249167;13138.934305328508;13189.340532973409;13229.867701322959;13316.533921312708;13422;11923.821142682868;11952.581659641957;12027.57903473383;12147.392630368535;12270.263784172977;4314.8146298090805;4368.628666563346;4386.232409328355;4435.667324950641;4608.5621865922685;56859.43140568583;57408.42591574073;57724;57961;58408.41591584115;10779.51492182838;10914.454277286262;11005.339679619248;11051.115910727123;11197.66407007791;17543.561410964827;17644.823551764573;17705.557361065818;17719.114044297734;17723.46829595114;7481.364084052916;7751.7674469766;7794.415418843496;7970.840583188304;8059.919400805917;4510.706804057726;4511.097780443924;4517.706349087364;4537.820166756601;4631.745254010994;3184.8885289014775;3282.556854824616;3283.5731354924183;3284.261041265696;3287.391832510993;600.0339453479894;601.3986013986014;602.6113157013789;608.178958406157;624.6533174088333;565.9037963546207;650.8991106378425;686.0087174033474;693.9555968267724;753.5779963220505;8279;8874.689385871463;9313.115254050854;9317.11487408695;9349.953250233706;632.1971096707156;696.8118607975819;743.3792783026125;785.7057392414164;828.4490813608883;4469.865904022885;4559.361689363492;4561.885952851205;4576.88557786058;4645.674802763774;65092.34907650958;67181;67296;69011.75376585386;69146.30853691499;58978;59289;60007;60083.39916600778;61346.38653613496;53092.73453632707;54462.45537544653;55763.999999999185;55870.441295587334;56153;9076.909230907606;9096.818063638559;9136.360454768102;9143.451392916446;9156;37294.627053730204;37729.2454150921;38112.428313575874;38629.613703862604;38912.2217555653;47024.529754702016;48841.755791220814;48948.2657760141;49636.50363496463;49751.75124124356;11005.150291254517;11082.113430925669;11192.888071119185;11291.209615327178;11579.363135027654;12385.62843114708;12515.56195533152;12831.935840320739;13081.542146024844;13103.934480327538;11849.229800062969;12242.326672033123;12268.693282668004;12314.692132696755;12688.492460301484;11427.200095993534;12133.878661213275;12236.265824050586;12496.937515312366;12638.178518396275;11796.174267801514;12152.149349545447;12251.509939602316;12272.447739851907;12277.754444910874;9956.303058785816;9990.300678952693;10041.899581004096;10259.333143345659;10400.27198096126;9960.153386962189;10185.185185185315;10203.183745300506;10266.946610678044;10283.94858025705 10:44:53 INFO - PROCESS | 3333 | __end_tp_report 10:44:53 INFO - PROCESS | 3333 | __start_cc_report 10:44:53 INFO - PROCESS | 3333 | _x_x_mozilla_cycle_collect,868 10:44:53 INFO - PROCESS | 3333 | __end_cc_report 10:44:53 INFO - PROCESS | 3333 | __startTimestamp1464111893666__endTimestamp 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | ------- Summary: start ------- 10:44:53 INFO - PROCESS | 3333 | Number of tests: 6 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#0] dojo.html Cycles:165 Average:5469.49 Median:5690.09 stddev:623.77 (11.0%) stddev-sans-first:599.16 10:44:53 INFO - PROCESS | 3333 | Values: 3175.4 3188.0 3204.3 3222.7 3247.6 5326.1 5388.7 5479.5 5506.9 5598.7 5465.5 5499.7 5505.0 5524.8 5567.2 4933.3 4985.9 5018.3 5028.2 5131.3 5032.4 5046.4 5064.7 5070.9 5089.9 4918.3 4976.2 4976.8 4980.9 5009.4 4959.7 4974.6 5033.1 5049.2 5066.9 4889.8 4971.9 5014.4 5024.9 5065.0 5274.9 5352.4 5363.4 5396.4 5405.1 5768.0 5814.1 5844.2 5851.5 5872.4 5619.7 5850.7 5992.2 6021.9 6027.2 5475.2 5489.6 5536.1 5543.1 5565.7 6046.4 6048.8 6069.3 6076.7 6087.2 5622.6 5763.1 5807.8 5810.3 5857.4 5929.9 5930.0 5932.3 5932.3 5972.9 5873.5 5909.9 5923.0 5925.1 5930.6 5690.1 5852.9 5900.2 5905.3 5915.0 4490.6 4493.5 4494.8 4495.1 4531.1 3976.6 4003.8 4012.2 4039.0 4067.0 5442.2 5476.3 5478.3 5492.3 5500.7 5848.2 5865.2 5889.3 5898.2 5945.5 5492.6 5500.0 5502.8 5505.1 5505.6 4947.8 5027.0 5036.7 5055.7 5061.0 6062.7 6078.1 6078.4 6086.2 6086.9 5831.7 5883.1 5885.7 5888.4 5895.3 5964.3 6091.5 6099.8 6100.7 6159.3 5803.7 5863.9 5865.6 5876.9 5905.4 5797.6 5911.9 5920.1 5926.4 5930.7 5767.4 5825.8 5836.4 5842.7 5851.0 5795.4 5826.5 5826.8 5829.6 5833.6 5562.1 5636.9 5642.2 5657.4 5679.2 5825.7 5870.5 5873.3 5877.7 5901.2 5722.9 5724.0 5726.0 5730.1 5744.5 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#1] ext.html Cycles:180 Average:58925.70 Median:42097.58 stddev:113430.44 (269.4%) stddev-sans-first:113664.05 10:44:53 INFO - PROCESS | 3333 | Values: 581.2 628.2 642.8 648.4 658.0 31573.5 34876.1 34889.7 43067.6 44176.8 43825.3 43924.3 44146.0 44203.8 44219.9 8655.1 8844.6 8849.7 8856.2 8865.9 8671.7 8754.6 8798.7 8801.1 8818.6 8785.4 8856.1 8858.3 8874.3 8882.0 8653.2 8729.1 8732.6 8733.9 8742.8 8680.1 8765.1 8772.8 8777.6 8780.1 41384.8 41816.8 41881.0 41907.8 41910.0 3353.3 3458.4 3593.6 3981.7 3985.2 31087.2 31454.2 31631.0 31691.5 32451.0 4282.7 4312.5 4329.0 4331.6 4481.1 341818.0 342950.0 343427.0 344076.0 346013.3 50109.7 55190.4 56382.2 56450.7 56959.4 54873.5 54980.7 55120.0 56498.7 56504.7 15915.2 16055.5 16095.4 16119.4 16156.0 12533.6 12620.7 12633.6 12644.3 12793.4 15796.5 15823.8 15906.8 15919.6 15937.7 6287.7 6446.9 6532.2 6603.5 6610.9 1038.3 1079.9 1089.1 1165.3 1197.2 32157.2 32286.2 32501.8 32718.5 33099.0 935.4 1132.9 1158.9 1223.2 1227.0 17055.8 17283.8 17312.5 17353.9 17418.5 467620.0 472433.0 472907.0 475260.0 475769.0 57264.4 57322.1 57352.0 57395.1 57418.0 1266.3 1321.4 1327.2 1342.2 1360.5 30678.7 34186.0 34583.7 34827.6 34859.1 50244.5 51064.5 51184.2 51215.7 51256.7 455280.0 458173.0 458178.0 460314.0 462857.0 38148.4 43710.3 43987.3 44542.3 45514.5 48466.5 48725.0 49091.8 49627.8 50293.0 40241.2 40309.2 40342.6 41866.8 42227.4 41134.0 41156.6 41365.6 41408.6 41886.8 40585.0 41470.8 41648.4 41993.6 42201.6 33919.3 36224.0 36618.0 36839.4 36855.4 28174.3 28248.4 28328.9 28490.0 28575.7 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#2] jquery.html Cycles:180 Average:27439.88 Median:401.12 stddev:73123.11 (18229.6%) stddev-sans-first:73300.05 10:44:53 INFO - PROCESS | 3333 | Values: 396.4 397.9 404.4 411.4 422.1 12838.5 18215.0 19631.0 19692.7 19716.1 18664.2 18761.1 19570.1 19692.6 19732.7 5547.8 5693.5 5731.3 5738.7 5746.0 5597.3 5673.4 5674.7 5688.8 5697.5 4127.9 6060.6 6374.2 6379.6 6515.7 5413.7 5732.7 6442.0 6482.8 6497.5 5610.7 5620.1 5628.6 5636.4 5639.7 13295.2 15998.2 20556.9 23506.5 23531.1 2297.2 2346.6 2647.3 2888.0 2958.4 9088.2 9862.1 10118.6 11556.9 14188.7 1878.9 1884.3 1895.8 1901.8 1999.9 73974.0 80807.0 82454.6 82612.0 85264.0 10798.4 10870.9 10992.3 11041.9 11212.2 15560.7 15618.5 15636.6 15645.7 15647.0 7831.7 7987.3 8029.4 8172.5 8202.0 7772.7 7822.2 7830.4 7949.8 7981.6 4518.5 4538.1 4541.9 4620.0 4832.1 1902.5 1929.4 1940.4 1956.6 1986.6 994.9 1010.5 1022.5 1032.8 1103.4 18206.3 18946.7 19207.5 19289.9 19434.0 971.6 979.9 986.8 996.3 1033.0 10607.5 10874.2 10936.5 10983.7 11008.8 417413.0 432885.0 449134.0 450487.0 456593.0 66153.0 95406.0 96096.0 98233.0 98649.5 997.5 1003.8 1005.2 1010.2 1040.6 16532.0 16896.0 16983.7 17055.4 17497.7 41693.8 41774.0 42781.8 42801.0 43362.1 53935.5 54095.0 56100.0 57974.1 63225.0 7842.7 8174.1 8185.4 8331.5 8491.8 11149.9 12675.7 13430.4 13684.1 14054.6 11369.3 11698.0 11753.0 11891.7 11999.1 8542.8 11595.5 11615.9 11768.4 11851.1 11742.5 11760.5 11769.5 11798.1 11887.1 8022.8 8119.0 8205.0 8218.6 8528.9 8369.5 9873.7 10652.9 11648.4 11655.8 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#3] mootools.html Cycles:180 Average:5846.62 Median:450.47 stddev:3315.79 (736.1%) stddev-sans-first:3307.98 10:44:53 INFO - PROCESS | 3333 | Values: 1363.7 1462.8 1516.8 1645.4 1810.7 8171.7 8437.7 8442.3 8444.8 8678.4 8108.4 8379.1 8584.2 8592.3 8592.8 1999.9 2230.5 2246.5 2282.3 2311.3 2340.9 2346.1 2346.6 2349.0 2349.1 2259.2 2263.1 2298.7 2306.6 2308.4 1934.9 2180.5 2239.4 2247.7 2256.2 2294.0 2299.2 2306.4 2311.1 2312.5 8569.8 8611.5 8621.3 8631.7 8652.4 5062.7 5218.2 5242.6 5244.8 5257.4 3251.1 3317.2 3362.4 3384.4 3388.1 1121.5 1121.8 1135.6 1137.2 1152.9 11576.5 11681.6 11742.0 11772.1 11773.0 4595.2 4670.3 4769.3 4771.6 4782.8 10532.5 10546.2 10552.8 10554.1 10561.0 5222.0 5228.5 5229.3 5232.1 5234.9 4291.2 4734.2 4886.2 4891.5 4932.4 4055.4 4117.6 4156.6 4184.9 4196.7 1265.8 1273.7 1280.7 1287.5 1301.3 1014.9 1039.5 1045.3 1045.3 1052.1 6120.9 6204.0 6223.9 6304.9 6320.3 450.4 450.6 450.7 455.2 460.8 4255.4 4281.8 4298.6 4406.9 4412.3 10810.7 11005.2 11130.6 11132.3 11161.6 10962.3 10981.1 11039.0 11058.9 11066.1 7849.7 8165.7 8343.7 8405.7 8442.6 6198.5 6270.9 6286.7 6338.2 6434.0 9915.8 10240.8 10342.1 10352.4 10392.2 10224.3 10309.0 10443.3 10453.7 10541.9 7039.2 7526.5 7689.1 7691.7 7815.7 8819.8 8853.9 8930.5 8930.5 8935.4 7768.4 7819.2 7835.5 8054.4 8148.2 7778.5 7813.9 7892.4 7914.4 7970.3 7245.3 7300.5 7353.0 7378.1 7382.7 5441.6 5491.2 5568.2 5580.0 5653.9 5455.7 5568.8 5591.6 5661.3 5679.6 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#4] prototype.html Cycles:180 Average:4658.46 Median:5275.67 stddev:1342.22 (25.4%) stddev-sans-first:1306.06 10:44:53 INFO - PROCESS | 3333 | Values: 329.0 340.6 344.3 345.8 348.2 5306.1 5318.6 5342.4 5357.8 5411.3 5054.4 5095.0 5166.4 5187.7 5325.9 4122.2 4157.9 4178.8 4192.0 4195.1 4182.7 4195.5 4198.9 4207.6 4222.1 4000.8 4012.2 4136.1 4140.8 4145.9 4130.9 4138.4 4144.9 4166.3 4173.7 3718.9 3724.7 3734.7 3742.0 3747.6 4964.7 4967.5 5101.7 5103.9 5187.5 4763.0 4770.2 4779.9 4783.6 4812.3 5462.9 5465.2 5468.0 5473.2 5525.9 3901.0 4042.9 4052.9 4052.9 4053.6 5576.4 5661.3 5667.9 5701.4 5709.2 4116.7 4128.6 4151.4 4161.9 4166.0 4101.7 4154.5 4162.0 4202.7 4218.9 4691.4 4698.4 4705.0 4718.2 4722.9 5479.7 5518.5 5561.4 5582.9 5586.5 1374.7 1430.6 1438.8 1454.2 1478.1 1002.6 1020.8 1028.1 1033.4 1037.5 5202.6 5203.7 5206.0 5289.3 5317.8 5613.2 5624.7 5635.2 5637.9 5643.0 5062.8 5247.8 5269.7 5281.6 5285.8 2969.0 2974.2 2986.0 2987.4 3005.1 5636.4 5681.8 5747.7 5810.4 5816.2 5520.3 5693.3 5710.9 5777.6 5781.3 5758.0 5773.0 5825.7 5875.2 5891.4 5561.5 5709.0 5719.3 5728.5 5740.1 5540.2 5575.6 5652.4 5671.2 5677.9 5801.7 5803.8 5818.2 5831.3 5872.0 3973.4 4038.7 4053.7 4056.2 4067.8 5674.4 5676.7 5708.9 5713.0 5756.2 5319.3 5391.3 5511.7 5525.4 5528.2 5441.3 5442.6 5443.2 5498.3 5502.1 5210.3 5369.8 5374.1 5420.4 5432.8 5504.7 5518.5 5525.2 5538.7 5551.9 5408.6 5422.1 5425.4 5440.9 5451.6 10:44:53 INFO - PROCESS | 3333 | 10:44:53 INFO - PROCESS | 3333 | [#5] yui.html Cycles:180 Average:15326.95 Median:4638.71 stddev:18645.31 (402.0%) stddev-sans-first:18665.32 10:44:53 INFO - PROCESS | 3333 | Values: 712.7 749.2 750.9 772.7 799.7 14032.2 14532.2 14538.8 15053.2 15107.8 13550.3 13674.3 13680.2 13687.1 13694.2 681.4 782.5 792.0 801.3 814.2 817.8 820.2 820.8 824.4 827.2 864.1 865.1 865.9 866.4 866.7 710.7 828.8 840.0 840.4 862.0 620.4 623.5 624.3 624.6 625.0 11869.2 11898.6 11911.3 11923.6 11986.7 13138.9 13189.3 13229.9 13316.5 13422.0 11923.8 11952.6 12027.6 12147.4 12270.3 4314.8 4368.6 4386.2 4435.7 4608.6 56859.4 57408.4 57724.0 57961.0 58408.4 10779.5 10914.5 11005.3 11051.1 11197.7 17543.6 17644.8 17705.6 17719.1 17723.5 7481.4 7751.8 7794.4 7970.8 8059.9 4510.7 4511.1 4517.7 4537.8 4631.7 3184.9 3282.6 3283.6 3284.3 3287.4 600.0 601.4 602.6 608.2 624.7 565.9 650.9 686.0 694.0 753.6 8279.0 8874.7 9313.1 9317.1 9350.0 632.2 696.8 743.4 785.7 828.4 4469.9 4559.4 4561.9 4576.9 4645.7 65092.3 67181.0 67296.0 69011.8 69146.3 58978.0 59289.0 60007.0 60083.4 61346.4 53092.7 54462.5 55764.0 55870.4 56153.0 9076.9 9096.8 9136.4 9143.5 9156.0 37294.6 37729.2 38112.4 38629.6 38912.2 47024.5 48841.8 48948.3 49636.5 49751.8 11005.2 11082.1 11192.9 11291.2 11579.4 12385.6 12515.6 12831.9 13081.5 13103.9 11849.2 12242.3 12268.7 12314.7 12688.5 11427.2 12133.9 12236.3 12496.9 12638.2 11796.2 12152.1 12251.5 12272.4 12277.8 9956.3 9990.3 10041.9 10259.3 10400.3 9960.2 10185.2 10203.2 10266.9 10283.9 10:44:53 INFO - PROCESS | 3333 | -------- Summary: end -------- 10:44:53 INFO - PROCESS | 3333 | 10:44:54 INFO - TEST-INFO | 3333: exit 0 10:44:54 INFO - TEST-OK | dromaeo_css | took 1112993ms 10:44:54 INFO - TEST-START | kraken 10:44:54 INFO - operating with platform_type : linux_ 10:44:54 INFO - Initialising browser for kraken test... 10:44:54 INFO - TEST-INFO | started process 3514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFCib7W/profile http://localhost:52695/getInfo.html) 10:44:58 INFO - PROCESS | 3514 | __metrics Screen width/height:1600/1200 10:44:58 INFO - PROCESS | 3514 | colorDepth:24 10:44:58 INFO - PROCESS | 3514 | Browser inner width/height: 1024/697 10:44:58 INFO - PROCESS | 3514 | __metrics 10:44:59 ERROR - PROCESS | 3514 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:45:00 INFO - TEST-INFO | 3514: exit 0 10:45:00 INFO - Browser initialized. 10:45:00 INFO - Running cycle 1/1 for kraken test... 10:45:00 INFO - TEST-INFO | started process 3598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFCib7W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:12 INFO - PROCESS | 3598 | RSS: Main: 153214976 10:45:12 INFO - PROCESS | 3598 | 10:45:14 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52695/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:15 INFO - PROCESS | 3598 | RSS: Main: 209489920 10:45:15 INFO - PROCESS | 3598 | 10:45:18 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52695/tests/kraken/driver.html?testName=audio-dft) 10:45:18 INFO - PROCESS | 3598 | RSS: Main: 197922816 10:45:18 INFO - PROCESS | 3598 | 10:45:22 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52695/tests/kraken/driver.html?testName=audio-fft) 10:45:22 INFO - PROCESS | 3598 | RSS: Main: 265633792 10:45:22 INFO - PROCESS | 3598 | 10:45:24 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52695/tests/kraken/driver.html?testName=audio-oscillator) 10:45:25 INFO - PROCESS | 3598 | RSS: Main: 174735360 10:45:25 INFO - PROCESS | 3598 | 10:45:27 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52695/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:45:28 INFO - PROCESS | 3598 | RSS: Main: 179437568 10:45:28 INFO - PROCESS | 3598 | 10:45:31 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52695/tests/kraken/driver.html?testName=imaging-darkroom) 10:45:31 INFO - PROCESS | 3598 | RSS: Main: 215293952 10:45:31 INFO - PROCESS | 3598 | 10:45:35 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52695/tests/kraken/driver.html?testName=imaging-desaturate) 10:45:35 INFO - PROCESS | 3598 | RSS: Main: 216166400 10:45:35 INFO - PROCESS | 3598 | 10:45:38 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52695/tests/kraken/driver.html?testName=json-parse-financial) 10:45:39 INFO - PROCESS | 3598 | RSS: Main: 216698880 10:45:39 INFO - PROCESS | 3598 | 10:45:40 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52695/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:45:41 INFO - PROCESS | 3598 | RSS: Main: 205889536 10:45:41 INFO - PROCESS | 3598 | 10:45:42 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:45:43 INFO - PROCESS | 3598 | RSS: Main: 207167488 10:45:43 INFO - PROCESS | 3598 | 10:45:45 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:45:46 INFO - PROCESS | 3598 | RSS: Main: 217178112 10:45:46 INFO - PROCESS | 3598 | 10:45:48 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:45:49 INFO - PROCESS | 3598 | RSS: Main: 223862784 10:45:49 INFO - PROCESS | 3598 | 10:45:52 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:45:52 INFO - PROCESS | 3598 | RSS: Main: 222326784 10:45:52 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | Cycle 1(1): loaded http://localhost:52695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52695/tests/kraken/driver.html?testName=ai-astar) 10:45:54 INFO - PROCESS | 3598 | RSS: Main: 268238848 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | __start_tp_report 10:45:54 INFO - PROCESS | 3598 | _x_x_mozilla_page_load 10:45:54 INFO - PROCESS | 3598 | _x_x_mozilla_page_load_details 10:45:54 INFO - PROCESS | 3598 | |i|pagename|runs| 10:45:54 INFO - PROCESS | 3598 | |0;ai-astar;112;105;111;110;111;111;110;110;111;109 10:45:54 INFO - PROCESS | 3598 | |1;audio-beat-detection;150;123;135;174;127;126;152;125;156;132 10:45:54 INFO - PROCESS | 3598 | |2;audio-dft;161;162;161;160;159;161;159;161;160;160 10:45:54 INFO - PROCESS | 3598 | |3;audio-fft;75;75;75;115;75;75;73;73;118;75 10:45:54 INFO - PROCESS | 3598 | |4;audio-oscillator;83;83;122;83;84;84;117;83;83;129 10:45:54 INFO - PROCESS | 3598 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 10:45:54 INFO - PROCESS | 3598 | |6;imaging-darkroom;146;146;146;145;145;144;145;145;145;145 10:45:54 INFO - PROCESS | 3598 | |7;imaging-desaturate;96;95;96;95;94;95;95;95;95;95 10:45:54 INFO - PROCESS | 3598 | |8;json-parse-financial;56;55;55;55;55;55;55;76;55;52 10:45:54 INFO - PROCESS | 3598 | |9;json-stringify-tinderbox;62;63;63;62;62;62;62;62;62;68 10:45:54 INFO - PROCESS | 3598 | |10;stanford-crypto-aes;79;79;85;80;80;80;85;80;80;79 10:45:54 INFO - PROCESS | 3598 | |11;stanford-crypto-ccm;124;125;126;118;118;125;120;121;222;129 10:45:54 INFO - PROCESS | 3598 | |12;stanford-crypto-pbkdf2;160;162;161;161;169;159;158;157;159;157 10:45:54 INFO - PROCESS | 3598 | |13;stanford-crypto-sha256-iterative;62;62;70;63;62;63;62;62;60;62 10:45:54 INFO - PROCESS | 3598 | __end_tp_report 10:45:54 INFO - PROCESS | 3598 | __start_cc_report 10:45:54 INFO - PROCESS | 3598 | _x_x_mozilla_cycle_collect,1613 10:45:54 INFO - PROCESS | 3598 | __end_cc_report 10:45:54 INFO - PROCESS | 3598 | __startTimestamp1464111954859__endTimestamp 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | ------- Summary: start ------- 10:45:54 INFO - PROCESS | 3598 | Number of tests: 14 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:1.92 10:45:54 INFO - PROCESS | 3598 | Values: 112.0 105.0 111.0 110.0 111.0 111.0 110.0 110.0 111.0 109.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.50 stddev:17.07 (12.0%) stddev-sans-first:17.72 10:45:54 INFO - PROCESS | 3598 | Values: 150.0 123.0 135.0 174.0 127.0 126.0 152.0 125.0 156.0 132.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 10:45:54 INFO - PROCESS | 3598 | Values: 161.0 162.0 161.0 160.0 159.0 161.0 159.0 161.0 160.0 160.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.74 (23.7%) stddev-sans-first:18.59 10:45:54 INFO - PROCESS | 3598 | Values: 75.0 75.0 75.0 115.0 75.0 75.0 73.0 73.0 118.0 75.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:19.24 (23.2%) stddev-sans-first:19.90 10:45:54 INFO - PROCESS | 3598 | Values: 83.0 83.0 122.0 83.0 84.0 84.0 117.0 83.0 83.0 129.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:45:54 INFO - PROCESS | 3598 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:45:54 INFO - PROCESS | 3598 | Values: 146.0 146.0 146.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:45:54 INFO - PROCESS | 3598 | Values: 96.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:55.00 stddev:6.79 (12.3%) stddev-sans-first:7.19 10:45:54 INFO - PROCESS | 3598 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 55.0 76.0 55.0 52.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.00 stddev:1.87 (3.0%) stddev-sans-first:1.96 10:45:54 INFO - PROCESS | 3598 | Values: 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 68.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.31 (2.9%) stddev-sans-first:2.37 10:45:54 INFO - PROCESS | 3598 | Values: 79.0 79.0 85.0 80.0 80.0 80.0 85.0 80.0 80.0 79.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:125.00 stddev:31.55 (25.2%) stddev-sans-first:33.30 10:45:54 INFO - PROCESS | 3598 | Values: 124.0 125.0 126.0 118.0 118.0 125.0 120.0 121.0 222.0 129.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:3.50 (2.2%) stddev-sans-first:3.71 10:45:54 INFO - PROCESS | 3598 | Values: 160.0 162.0 161.0 161.0 169.0 159.0 158.0 157.0 159.0 157.0 10:45:54 INFO - PROCESS | 3598 | 10:45:54 INFO - PROCESS | 3598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:2.66 (4.3%) stddev-sans-first:2.80 10:45:54 INFO - PROCESS | 3598 | Values: 62.0 62.0 70.0 63.0 62.0 63.0 62.0 62.0 60.0 62.0 10:45:54 INFO - PROCESS | 3598 | -------- Summary: end -------- 10:45:54 INFO - PROCESS | 3598 | 10:45:55 INFO - TEST-INFO | 3598: exit 0 10:45:55 INFO - TEST-OK | kraken | took 61486ms 10:45:55 INFO - SUITE-END | took 1174s 10:45:56 INFO - Completed test suite (00:19:34) 10:45:56 INFO - javascript benchmark 10:45:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.4284228838806, 3187.9521807172882, 3204.3431096625186, 3222.661620529843, 3247.6102867655886, 5326.121190003654, 5388.703621300827, 5479.4794494523, 5506.917396239055, 5598.748056337465, 5465.480779325968, 5499.670019798805, 5505.0, 5524.8342549723475, 5567.248421463101, 4933.309336692866, 4985.925211121836, 5018.2974383586325, 5028.195488721805, 5131.307273518065, 5032.4212715537815, 5046.369203849519, 5064.746762661871, 5070.923936140943, 5089.949100509003, 4918.311436398907, 4976.203807390818, 4976.776045077981, 4980.850574482772, 5009.398872135331, 4959.677620954626, 4974.602031837444, 5033.0688822567945, 5049.166887463564, 5066.898662026776, 4889.804407823683, 4971.850844474671, 5014.423341315759, 5024.924626130611, 5065.0, 5274.868128296785, 5352.384475785296, 5363.436839131913, 5396.43337449566, 5405.108157154064, 5768.0, 5814.098814683731, 5844.1818145459665, 5851.502622277111, 5872.412758724136, 5619.719014049322, 5850.736716847752, 5992.161097446361, 6021.939780602225, 6027.216461859974, 5475.178723191553, 5489.560835133179, 5536.058869992071, 5543.1408131739645, 5565.666060036411, 6046.356727093757, 6048.818535443944, 6069.302030266487, 6076.696165191723, 6087.239095113111, 5622.606417550732, 5763.106718458645, 5807.767689292381, 5810.331811841692, 5857.414258574194, 5929.851753706192, 5930.021546444875, 5932.2584676915385, 5932.3474417814, 5972.910406343908, 5873.530117590582, 5909.852253693606, 5923.0, 5925.081612350093, 5930.644161350333, 5690.089585666274, 5852.882942341129, 5900.1739756434135, 5905.291365036223, 5915.0, 4490.550944905549, 4493.483249426358, 4494.752788596658, 4495.123450927038, 4531.13908357411, 3976.6421022108148, 4003.779792111462, 4012.217617564547, 4039.0104424415617, 4066.9832541864535, 5442.156465747816, 5476.315460567429, 5478.342598888079, 5492.313460817398, 5500.724963751796, 5848.152017957373, 5865.237519122486, 5889.263842019747, 5898.203742494708, 5945.464908158287, 5492.642978206404, 5499.972500137474, 5502.8349149525575, 5505.064139096363, 5505.642133261325, 4947.802087916443, 5027.044861476308, 5036.722980236123, 5055.671381360274, 5061.038402703474, 6062.666553339609, 6078.149059131725, 6078.392160783975, 6086.239220097488, 6086.908696369558, 5831.708414579339, 5883.0881213411985, 5885.705714714333, 5888.352281248974, 5895.263092113486, 5964.343922168645, 6091.511430256314, 6099.794059995639, 6100.694965251809, 6159.260888693386, 5803.651780892991, 5863.853403664943, 5865.589408741347, 5876.911846322394, 5905.43898329658, 5797.623154494944, 5911.881762364643, 5920.052791553331, 5926.407359264212, 5930.733117009831, 5767.365589785204, 5825.76696932118, 5836.358000620014, 5842.678652673973, 5851.034579294369, 5795.39148389413, 5826.533877289891, 5826.796062137805, 5829.59192856496, 5833.562482813721, 5562.110062389998, 5636.887262254814, 5642.153676948326, 5657.3776884543495, 5679.233303504139, 5825.650460972355, 5870.530357571299, 5873.2658417697785, 5877.706114694333, 5901.232839730979, 5722.885542289214, 5724.026915424472, 5726.0, 5730.054541000855, 5744.4829965303325], "value": 5427.432179049332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1921429213394, 628.1551313483365, 642.8103709405725, 648.3905129178572, 657.9736810527579, 31573.526397104033, 34876.12809679759, 34889.651103488955, 43067.56932430675, 44176.77911610445, 43825.34261986065, 43924.341134883005, 44146.0, 44203.77898110513, 44219.89450263745, 8655.0912154224, 8844.646214151426, 8849.734507964771, 8856.202941735275, 8865.911340886572, 8671.739847804576, 8754.606042728092, 8798.736037918841, 8801.119888011179, 8818.603162857655, 8785.428947118417, 8856.114388561125, 8858.29133669305, 8874.290056795473, 8882.022977472505, 8653.177948094952, 8729.08344623818, 8732.563371831384, 8733.912660873406, 8742.781430464225, 8680.08859069795, 8765.079666634976, 8772.824543509094, 8777.64889404423, 8780.078091800333, 41384.79307603473, 41816.790916045225, 41881.0, 41907.79046104781, 41910.0, 3353.295807880348, 3458.360203362361, 3593.568771747407, 3981.7212795104356, 3985.163115745697, 31087.222819429695, 31454.213644658837, 31631.0, 31691.524627130613, 32451.02646920596, 4282.657387409, 4312.482502099768, 4328.956710432887, 4331.5884990925815, 4481.103779244164, 341818.0, 342950.0, 343427.0, 344076.0, 346013.26993365126, 50109.74945125251, 55190.448095519336, 56382.15426768602, 56450.71774641183, 56959.43040569541, 54873.45126548763, 54980.72509637506, 55120.0, 56498.71750641303, 56504.71747641318, 15915.204239787965, 16055.518334449986, 16095.356185752673, 16119.435819746253, 16156.0, 12533.561325353568, 12620.684482888002, 12633.557825476064, 12644.304563248925, 12793.360331983364, 15796.526104216891, 15823.762643560356, 15906.76139857903, 15919.602009949844, 15937.681246375008, 6287.717052732638, 6446.903296450557, 6532.248791389051, 6603.537752357385, 6610.900836487456, 1038.309524166421, 1079.9028087472166, 1089.057964860406, 1165.2542372881362, 1197.2277880766856, 32157.196070097965, 32286.19284517906, 32501.837490812395, 32718.509222361685, 33099.0, 935.3826474526779, 1132.903703185222, 1158.8725240223569, 1223.2049168040667, 1227.0, 17055.829441705424, 17283.827161728474, 17312.480625581, 17353.913230433765, 17418.47744567665, 467620.0, 472433.0, 472907.0, 475260.0, 475769.0, 57264.42735572591, 57322.140167897516, 57352.0, 57395.13907291394, 57418.0, 1266.2845492296822, 1321.4119716726157, 1327.2368388176837, 1342.2282187741891, 1360.4626172661742, 30678.693213068476, 34186.0, 34583.65416345804, 34827.55004718866, 34859.128521787155, 50244.497555025446, 51064.48935510597, 51184.23223651723, 51215.743921280155, 51256.74371628118, 455280.0, 458173.0, 458178.0, 460314.0, 462857.0, 38148.427773582865, 43710.34434483549, 43987.34018989782, 44542.331865021406, 45514.544854552354, 48466.51533484761, 48725.0, 49091.75454122706, 49627.75186124046, 50293.0, 40241.1951760969, 40309.1938161241, 40342.59657403389, 41866.79066604647, 42227.36658950057, 41134.0, 41156.58843411528, 41365.58634413738, 41408.58591414047, 41886.79056604819, 40585.0, 41470.79264603658, 41648.375274371516, 41993.58006420019, 42201.577984219766, 33919.321613568085, 36224.0, 36618.0, 36839.44740828943, 36855.44716829303, 28174.2956426091, 28248.43503129967, 28328.85835570809, 28490.0, 28575.714242857306], "value": 20081.72498839176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.4370593756866, 397.8687033279018, 404.3792778085639, 411.3788179848429, 422.12830505007156, 12838.48646054159, 18215.0, 19631.0, 19692.704609430853, 19716.112774925146, 18664.16011279492, 18761.061946902635, 19570.11934462949, 19692.606147877068, 19732.730735965368, 5547.750351234194, 5693.516051135658, 5731.254936858202, 5738.684372359518, 5746.0, 5597.3003374578175, 5673.404292549285, 5674.687892165929, 5688.772449102052, 5697.487226149646, 4127.855525056623, 6060.575759696823, 6374.203224596926, 6379.617222966637, 6515.739370425201, 5413.729313534347, 5732.713364331767, 6441.967790161019, 6482.773102941374, 6497.545171837974, 5610.747516361774, 5620.128880023562, 5628.577856660767, 5636.436356364372, 5639.68981706006, 13295.202287862663, 15998.200089995453, 20556.897215513975, 23506.529869402515, 23531.058757649673, 2297.1615360393503, 2346.601077816775, 2647.3116989582654, 2887.985560072186, 2958.393529326483, 9088.227500662451, 9862.063104005108, 10118.595256189743, 11556.94221528887, 14188.716225675533, 1878.8684792064562, 1884.3498992847447, 1895.8388536974373, 1901.7622797150357, 1999.8900060496667, 73974.0, 80807.0, 82454.58772706157, 82612.0, 85264.0, 10798.406087665096, 10870.891291087146, 10992.29619408993, 11041.944790275997, 11212.159088068427, 15560.688786224213, 15618.531444056696, 15636.609084772972, 15645.687086258211, 15647.0, 7831.686732530635, 7987.281144697005, 8029.4379393441895, 8172.509649421054, 8202.0, 7772.727954521678, 7822.217778222246, 7830.412719046094, 7949.841003179904, 7981.600919953979, 4518.480374756945, 4538.11506756186, 4541.863744087683, 4619.95380046202, 4832.106060378771, 1902.5243689077731, 1929.4211736479, 1940.417874637603, 1956.6380219659409, 1986.5828176082896, 994.9353292035994, 1010.4644538394663, 1022.539857064324, 1032.7727899862018, 1103.365564800243, 18206.271749130152, 18946.715799263024, 19207.51981200481, 19289.9479135486, 19434.0, 971.640493017588, 979.8775153105862, 986.7779749556292, 996.2577879479834, 1033.039273475675, 10607.522661480252, 10874.156033431593, 10936.453177341102, 10983.670489885317, 11008.834867476995, 417413.0, 432885.0, 449134.0, 450487.0, 456593.0, 66153.00770488447, 95406.0, 96096.0, 98233.0, 98649.50675246578, 997.4563862694848, 1003.7841863999275, 1005.2058873490007, 1010.2372708604956, 1040.6201736366322, 16532.008079514788, 16896.0, 16983.745243821104, 17055.403060892808, 17497.650046999242, 41693.79153104215, 41774.0, 42781.78609106935, 42801.0, 43362.13275734404, 53935.46064539461, 54095.0, 56100.0, 57974.13038804506, 63225.0, 7842.725504607311, 8174.141715119827, 8185.386096042702, 8331.50010999342, 8491.830163396575, 11149.94425027902, 12675.746485070431, 13430.39563219638, 13684.110532815335, 14054.578362649137, 11369.2609980351, 11698.0, 11753.0, 11891.702707432038, 11999.100067495147, 8542.82914341722, 11595.536178552764, 11615.941920290345, 11768.411579420823, 11851.111166662362, 11742.471588778355, 11760.529578816751, 11769.529218831492, 11798.056155507711, 11887.108466865193, 8022.799430014296, 8119.0, 8204.958975205085, 8218.589070546568, 8528.914710852812, 8369.49783013021, 9873.703788886345, 10652.946735266274, 11648.41757912084, 11655.825162622397], "value": 9137.717063208442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.6659018540447, 1462.7805829125632, 1516.7573188289873, 1645.432325847583, 1810.7012342963403, 8171.673133074677, 8437.746867593982, 8442.28240599549, 8444.788880277996, 8678.39251252411, 8108.351331893449, 8379.120192379789, 8584.184502472272, 8592.26965707914, 8592.828143437127, 1999.940001799941, 2230.531588366437, 2246.4608493961414, 2282.269673704407, 2311.3297143828268, 2340.9414764630937, 2346.1319311854636, 2346.601077816775, 2348.9530209395803, 2349.083857295656, 2259.186692790594, 2263.1173842201474, 2298.678185054094, 2306.630939049752, 2308.4459729664927, 1934.8839069655867, 2180.465785882469, 2239.3505883293824, 2247.6740872573387, 2256.2103263857684, 2294.025039358266, 2299.1608063056865, 2306.3542208181734, 2311.0755697721047, 2312.5490529346785, 8569.828603427959, 8611.526366049864, 8621.310295176434, 8631.65473381064, 8652.351073669437, 5062.670926389773, 5218.217267409919, 5242.6330156889035, 5244.79020839166, 5257.369115706101, 3251.089694885436, 3317.170707323169, 3362.411577973845, 3384.4077286475012, 3388.1190890368434, 1121.506537123663, 1121.775644871029, 1135.5571327182406, 1137.243732917609, 1152.8674202466657, 11576.53693852245, 11681.649550513413, 11742.001929835975, 11772.058235341237, 11773.0, 4595.241785105487, 4670.322803193586, 4769.332293478916, 4771.642126840501, 4782.832600859023, 10532.526036328383, 10546.156307495383, 10552.788944221073, 10554.050135487843, 10561.049505544537, 5222.033923724123, 5228.503292187236, 5229.320188375563, 5232.136697444955, 5234.947650523446, 4291.163223171452, 4734.171519983989, 4886.169351210303, 4891.461939186686, 4932.4081110267, 4055.398117743534, 4117.629413352813, 4156.594511150921, 4184.853530126492, 4196.685248606367, 1265.8038004109378, 1273.6688461000022, 1280.6542233596876, 1287.5493577248076, 1301.342821874966, 1014.9188064954786, 1039.4958445154093, 1045.3153184664056, 1045.3205416479198, 1052.1004541117388, 6120.908186377208, 6203.96898015507, 6223.906641400383, 6304.936950630527, 6320.336364681734, 450.3964687319008, 450.5517010574499, 450.70929250633156, 455.153414648753, 460.8456167184031, 4255.446791917031, 4281.828726850953, 4298.63461605767, 4406.889827754332, 4412.33814927757, 10810.67567972962, 11005.17461190414, 11130.554777808797, 11132.332060076422, 11161.553537858557, 10962.342259464458, 10981.066609338135, 11039.0, 11058.944705276583, 11066.059384952208, 7849.686012559548, 8165.673373065011, 8343.749687509384, 8405.747827565183, 8442.57787110642, 6198.473129784019, 6270.9372906270355, 6286.6856657166045, 6338.239411270677, 6434.002729576923, 9915.801683966136, 10240.846387304047, 10342.069213770797, 10352.430616316175, 10392.220583456423, 10224.335418197794, 10308.96910308963, 10443.321184123008, 10453.738656533344, 10541.947290263806, 7039.225685174524, 7526.473146879885, 7689.077310722749, 7691.653875575501, 7815.726449574465, 8819.823603528022, 8853.911460885309, 8930.464172149692, 8930.508822014852, 8935.419197752126, 7768.417368697484, 7819.178986206366, 7835.451518393657, 8054.37925148924, 8148.185181481805, 7778.455508114378, 7813.882791758015, 7892.447528672938, 7914.366850652049, 7970.322522585645, 7245.311695388929, 7300.525465844916, 7352.963235184004, 7378.114626244885, 7382.704691812482, 5441.646292990943, 5491.176323551499, 5568.192612071308, 5580.0, 5653.915191272052, 5455.727213639381, 5568.832935011957, 5591.608587399006, 5661.264035675335, 5679.6024278301775], "value": 4597.373576811822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.00911938189756, 340.60489831795115, 344.33371426290114, 345.7752460900416, 348.2286734882236, 5306.097963346231, 5318.601104917132, 5342.358916929969, 5357.785688572458, 5411.323584551931, 5054.393472783262, 5095.0, 5166.354205724285, 5187.6628019178725, 5325.920111198326, 4122.196171746511, 4157.8544750933725, 4178.8328466861285, 4192.0, 4195.056112374707, 4182.6862985276075, 4195.538490766014, 4198.895027624303, 4207.600277973587, 4222.134462435193, 4000.7595746381976, 4012.1975604878994, 4136.110736191718, 4140.81366338514, 4145.917081658365, 4130.876073717794, 4138.358554424069, 4144.896377590554, 4166.312558427856, 4173.749575025508, 3718.9029236375336, 3724.7392682512236, 3734.6638802507905, 3742.0, 3747.64397382251, 4964.702117872939, 4967.528084831935, 5101.7194054327, 5103.9234411483485, 5187.507186817246, 4763.023580166057, 4770.165221086296, 4779.880502987418, 4783.612752301829, 4812.25410061441, 5462.863428414282, 5465.180222966547, 5468.031508656881, 5473.2063850741415, 5525.922445123203, 3901.0, 4042.898927526806, 4052.9392059119136, 4052.9392059119136, 4053.5541090480024, 5576.414476479992, 5661.348944871352, 5667.943320566824, 5701.401352857932, 5709.229254050691, 4116.711830171859, 4128.587141285908, 4151.398047283127, 4161.854335098317, 4166.0, 4101.692373072032, 4154.480689913761, 4162.0, 4202.684798640114, 4218.878030257649, 4691.39011928454, 4698.389209402756, 4705.023889966223, 4718.197906355927, 4722.858314250578, 5479.698616576047, 5518.475744804237, 5561.360443548962, 5582.888342233214, 5586.525145362609, 1374.7250549890061, 1430.5636780781754, 1438.841727409984, 1454.1565891782952, 1478.0835881753383, 1002.5588740953957, 1020.7907378987289, 1028.1055481730941, 1033.3748082410034, 1037.455335948633, 5202.557782588522, 5203.687778733288, 5206.0, 5289.2859463972645, 5317.8404647860625, 5613.214150019001, 5624.71876406178, 5635.154726791015, 5637.887242255132, 5642.956053130184, 5062.822801202014, 5247.790088396498, 5269.736513174326, 5281.603879709037, 5285.788568457296, 2969.0107627889365, 2974.182099922495, 2985.9701402986125, 2987.4323878463024, 3005.128512731327, 5636.408177141423, 5681.772729090872, 5747.683877386784, 5810.360860305363, 5816.2148110005455, 5520.282363292827, 5693.28833895763, 5710.857228569236, 5777.595568310262, 5781.306243250837, 5757.971210143923, 5773.0, 5825.679587622722, 5875.206847075676, 5891.351951285355, 5561.499465048003, 5709.030384517335, 5719.283340413437, 5728.455796699307, 5740.13897915316, 5540.171743324774, 5575.637583557056, 5652.434756524314, 5671.234383358359, 5677.886442271214, 5801.738921748447, 5803.82588522345, 5818.156367326629, 5831.329397119216, 5871.970640146943, 3973.4437178794415, 4038.6970977176243, 4053.70281509914, 4056.1887622476215, 4067.8372865085066, 5674.432556744293, 5676.659400435987, 5708.857278568069, 5713.028785106459, 5756.1941328214925, 5319.308489896289, 5391.29913111293, 5511.724413779375, 5525.392206857323, 5528.170774383714, 5441.29263195782, 5442.605253688364, 5443.156310771837, 5498.257735205696, 5502.138887778253, 5210.25456472071, 5369.758360873692, 5374.086405311028, 5420.376656684374, 5432.8047829477455, 5504.651360416724, 5518.53092487127, 5525.226468294361, 5538.723063846872, 5551.8889622206525, 5408.621396502207, 5422.078246697992, 5425.403205647454, 5440.891182176413, 5451.591130665295], "value": 4238.684457017108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6579241963857, 749.243264303054, 750.8685979953507, 772.675476299954, 799.7480793550035, 14032.15807051575, 14532.200728959902, 14538.781918271234, 15053.247337633102, 15107.773383399257, 13550.254735989542, 13674.316284185776, 13680.179189248653, 13687.110337828035, 13694.178349299023, 681.3629256645053, 782.5422128055095, 791.9920800791976, 801.2708435323857, 814.238686827815, 817.7710241132493, 820.2084987986592, 820.7578764264556, 824.3981893217955, 827.1728271728272, 864.0668078475231, 865.1262225152578, 865.8528050231445, 866.4324867211986, 866.7269810009826, 710.683745733149, 828.7555171224473, 840.0129847429246, 840.4201101240125, 861.9525926074064, 620.3734228429274, 623.4607064888884, 624.3350831364628, 624.5815303746501, 624.9968750156265, 11869.169158158933, 11898.583549575724, 11911.285322880569, 11923.642290731292, 11986.70033249167, 13138.934305328508, 13189.340532973409, 13229.867701322959, 13316.533921312708, 13422.0, 11923.821142682868, 11952.581659641957, 12027.57903473383, 12147.392630368535, 12270.263784172977, 4314.8146298090805, 4368.628666563346, 4386.232409328355, 4435.667324950641, 4608.5621865922685, 56859.43140568583, 57408.42591574073, 57724.0, 57961.0, 58408.41591584115, 10779.51492182838, 10914.454277286262, 11005.339679619248, 11051.115910727123, 11197.66407007791, 17543.561410964827, 17644.823551764573, 17705.557361065818, 17719.114044297734, 17723.46829595114, 7481.364084052916, 7751.7674469766, 7794.415418843496, 7970.840583188304, 8059.919400805917, 4510.706804057726, 4511.097780443924, 4517.706349087364, 4537.820166756601, 4631.745254010994, 3184.8885289014775, 3282.556854824616, 3283.5731354924183, 3284.261041265696, 3287.391832510993, 600.0339453479894, 601.3986013986014, 602.6113157013789, 608.178958406157, 624.6533174088333, 565.9037963546207, 650.8991106378425, 686.0087174033474, 693.9555968267724, 753.5779963220505, 8279.0, 8874.689385871463, 9313.115254050854, 9317.11487408695, 9349.953250233706, 632.1971096707156, 696.8118607975819, 743.3792783026125, 785.7057392414164, 828.4490813608883, 4469.865904022885, 4559.361689363492, 4561.885952851205, 4576.88557786058, 4645.674802763774, 65092.34907650958, 67181.0, 67296.0, 69011.75376585386, 69146.30853691499, 58978.0, 59289.0, 60007.0, 60083.39916600778, 61346.38653613496, 53092.73453632707, 54462.45537544653, 55763.999999999185, 55870.441295587334, 56153.0, 9076.909230907606, 9096.818063638559, 9136.360454768102, 9143.451392916446, 9156.0, 37294.627053730204, 37729.2454150921, 38112.428313575874, 38629.613703862604, 38912.2217555653, 47024.529754702016, 48841.755791220814, 48948.2657760141, 49636.50363496463, 49751.75124124356, 11005.150291254517, 11082.113430925669, 11192.888071119185, 11291.209615327178, 11579.363135027654, 12385.62843114708, 12515.56195533152, 12831.935840320739, 13081.542146024844, 13103.934480327538, 11849.229800062969, 12242.326672033123, 12268.693282668004, 12314.692132696755, 12688.492460301484, 11427.200095993534, 12133.878661213275, 12236.265824050586, 12496.937515312366, 12638.178518396275, 11796.174267801514, 12152.149349545447, 12251.509939602316, 12272.447739851907, 12277.754444910874, 9956.303058785816, 9990.300678952693, 10041.899581004096, 10259.333143345659, 10400.27198096126, 9960.153386962189, 10185.185185185315, 10203.183745300506, 10266.946610678044, 10283.94858025705], "value": 6714.047599716247, "unit": "score"}], "name": "dromaeo_css", "value": 7120.3368396374735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 135.0, 174.0, 127.0, 126.0, 152.0, 125.0, 156.0, 132.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 159.0, 161.0, 159.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 115.0, 75.0, 75.0, 73.0, 73.0, 118.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 83.0, 84.0, 84.0, 117.0, 83.0, 83.0, 129.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 76.0, 55.0, 52.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 68.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 80.0, 80.0, 80.0, 85.0, 80.0, 80.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 126.0, 118.0, 118.0, 125.0, 120.0, 121.0, 222.0, 129.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 169.0, 159.0, 158.0, 157.0, 159.0, 157.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 70.0, 63.0, 62.0, 63.0, 62.0, 62.0, 60.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1501.7999999999997, "alertThreshold": 2.0}]} 10:45:56 INFO - Return code: 0 10:45:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:45:56 ERROR - # TBPL SUCCESS # 10:45:56 INFO - Running post-action listener: _resource_record_post_action 10:45:56 INFO - ##### 10:45:56 INFO - ##### Finished run-tests step (success) 10:45:56 INFO - ##### 10:45:56 INFO - Running post-run listener: _resource_record_post_run 10:45:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545579008; Read time: 16; Write time: 567948 10:45:56 INFO - TinderboxPrint: CPU usage
13.1% 10:45:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:45:56 INFO - TinderboxPrint: I/O write bytes / time
545,579,008 / 567,948 10:45:56 INFO - TinderboxPrint: CPU idle
8,264.8 (86.9%) 10:45:56 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 10:45:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:45:56 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254283776; Read time: 0; Write time: 343728 10:45:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290648064; Read time: 16; Write time: 224212 10:45:56 INFO - Running post-run listener: _upload_blobber_files 10:45:56 INFO - Blob upload gear active. 10:45:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:45:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:58 INFO - (blobuploader) - INFO - Done attempting. 10:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:58 INFO - (blobuploader) - INFO - Done attempting. 10:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:02 INFO - (blobuploader) - INFO - Done attempting. 10:46:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:02 INFO - Return code: 0 10:46:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efaa0d510bebbe3a5bb53380f6a6d95e4cc8b907e072783107dd7e0bc1a28d13adc4c2afe79e5a9507ce4911ea14c418cd29ff075e4a45f8cf2c2105e02dff89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa1cc27dbb5c0cb9f100f0b37b499dc05da1f80e0d2f42becb08bb13b9b680ee63c33e88581956c8a52544195bd504e8c492c05e7535af85f826a586f43bac32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/421ead244c68b3201f51fb72601d5a3e90062444a95e3dd3ba3913d478627a188ec618f58c9bd063c3a82d7b29cdfde4e12f93c79108f65ead2fad58fbbc5aad"} 10:46:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:02 INFO - Contents: 10:46:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efaa0d510bebbe3a5bb53380f6a6d95e4cc8b907e072783107dd7e0bc1a28d13adc4c2afe79e5a9507ce4911ea14c418cd29ff075e4a45f8cf2c2105e02dff89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa1cc27dbb5c0cb9f100f0b37b499dc05da1f80e0d2f42becb08bb13b9b680ee63c33e88581956c8a52544195bd504e8c492c05e7535af85f826a586f43bac32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/421ead244c68b3201f51fb72601d5a3e90062444a95e3dd3ba3913d478627a188ec618f58c9bd063c3a82d7b29cdfde4e12f93c79108f65ead2fad58fbbc5aad"} 10:46:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:02 INFO - Copying logs to upload dir... 10:46:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.730523 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 10:46:02.241639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:46:02.245226) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 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/efaa0d510bebbe3a5bb53380f6a6d95e4cc8b907e072783107dd7e0bc1a28d13adc4c2afe79e5a9507ce4911ea14c418cd29ff075e4a45f8cf2c2105e02dff89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa1cc27dbb5c0cb9f100f0b37b499dc05da1f80e0d2f42becb08bb13b9b680ee63c33e88581956c8a52544195bd504e8c492c05e7535af85f826a586f43bac32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/421ead244c68b3201f51fb72601d5a3e90062444a95e3dd3ba3913d478627a188ec618f58c9bd063c3a82d7b29cdfde4e12f93c79108f65ead2fad58fbbc5aad"} build_url:https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/B3z5HXA8SCqY1hs-XREbkg/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/efaa0d510bebbe3a5bb53380f6a6d95e4cc8b907e072783107dd7e0bc1a28d13adc4c2afe79e5a9507ce4911ea14c418cd29ff075e4a45f8cf2c2105e02dff89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa1cc27dbb5c0cb9f100f0b37b499dc05da1f80e0d2f42becb08bb13b9b680ee63c33e88581956c8a52544195bd504e8c492c05e7535af85f826a586f43bac32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/421ead244c68b3201f51fb72601d5a3e90062444a95e3dd3ba3913d478627a188ec618f58c9bd063c3a82d7b29cdfde4e12f93c79108f65ead2fad58fbbc5aad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:46:02.271293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:46:02.271718) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464110726.942343-409702023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:46:02.354003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:46:02.354361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:46:02.354739) ========= ========= Total master_lag: 0.16 =========