builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1461766292.73 results: success (0) buildid: 20160427043020 builduid: 44ec26cb7d8342d88010b23463c81eb7 revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.726513) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.726914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.727209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.748755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.749068) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 07:11:33-- 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% 95.2M=0s 2016-04-27 07:11:33 (95.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.880876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.881175) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:32.930392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 07:11:32.930718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --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 ab0044bfa1df858919797bcd6a9aef76a668cd4a --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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 07:11:33,601 truncating revision to first 12 chars 2016-04-27 07:11:33,601 Setting DEBUG logging. 2016-04-27 07:11:33,601 attempt 1/10 2016-04-27 07:11:33,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab0044bfa1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 07:11:34,426 unpacking tar archive at: mozilla-central-ab0044bfa1df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 07:11:34.049051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:34.049379) ========= script_repo_revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:34.049774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:34.050065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:11:34.061354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-04-27 07:11:34.061657) ========= /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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:11:34 INFO - MultiFileLogger online at 20160427 07:11:34 in /builds/slave/test 07:11:34 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 07:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:34 INFO - {'append_to_log': False, 07:11:34 INFO - 'base_work_dir': '/builds/slave/test', 07:11:34 INFO - 'blob_upload_branch': 'Firefox', 07:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:34 INFO - 'branch': 'Firefox', 07:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:34 INFO - 'config_files': ('talos/linux_config.py',), 07:11:34 INFO - 'default_actions': ('clobber', 07:11:34 INFO - 'read-buildbot-config', 07:11:34 INFO - 'download-and-extract', 07:11:34 INFO - 'populate-webroot', 07:11:34 INFO - 'create-virtualenv', 07:11:34 INFO - 'install', 07:11:34 INFO - 'run-tests'), 07:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:34 INFO - 'download_minidump_stackwalk': True, 07:11:34 INFO - 'download_symbols': 'ondemand', 07:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:34 INFO - 'installer_path': 'installer.exe', 07:11:34 INFO - 'log_level': 'info', 07:11:34 INFO - 'log_name': 'talos', 07:11:34 INFO - 'log_to_console': True, 07:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:11:34 INFO - 'opt_config_files': (), 07:11:34 INFO - 'pip_index': False, 07:11:34 INFO - 'sps_profile': False, 07:11:34 INFO - 'sps_profile_interval': 0, 07:11:34 INFO - 'suite': 'dromaeojs', 07:11:34 INFO - 'system_bits': '32', 07:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:34 INFO - 'title': 'talos-linux64-ix-039', 07:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:34 INFO - 'use_talos_json': True, 07:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:34 INFO - 'work_dir': 'build'} 07:11:34 INFO - ##### 07:11:34 INFO - ##### Running clobber step. 07:11:34 INFO - ##### 07:11:34 INFO - Running pre-action listener: _resource_record_pre_action 07:11:34 INFO - Running main action method: clobber 07:11:34 INFO - rmtree: /builds/slave/test/build 07:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:35 INFO - Running post-action listener: _resource_record_post_action 07:11:35 INFO - ##### 07:11:35 INFO - ##### Running read-buildbot-config step. 07:11:35 INFO - ##### 07:11:35 INFO - Running pre-action listener: _resource_record_pre_action 07:11:35 INFO - Running main action method: read_buildbot_config 07:11:35 INFO - Using buildbot properties: 07:11:35 INFO - { 07:11:35 INFO - "project": "", 07:11:35 INFO - "product": "firefox", 07:11:35 INFO - "script_repo_revision": "production", 07:11:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:11:35 INFO - "repository": "", 07:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:11:35 INFO - "buildid": "20160427043020", 07:11:35 INFO - "pgo_build": "True", 07:11:35 INFO - "basedir": "/builds/slave/test", 07:11:35 INFO - "buildnumber": 424, 07:11:35 INFO - "slavename": "talos-linux64-ix-039", 07:11:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:11:35 INFO - "platform": "ubuntu64_hw", 07:11:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:11:35 INFO - "branch": "mozilla-central", 07:11:35 INFO - "repo_path": "mozilla-central", 07:11:35 INFO - "revision": "ab0044bfa1df858919797bcd6a9aef76a668cd4a", 07:11:35 INFO - "stage_platform": "linux64-pgo", 07:11:35 INFO - "builduid": "44ec26cb7d8342d88010b23463c81eb7", 07:11:35 INFO - "slavebuilddir": "test" 07:11:35 INFO - } 07:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:11:35 INFO - Running post-action listener: _resource_record_post_action 07:11:35 INFO - ##### 07:11:35 INFO - ##### Running download-and-extract step. 07:11:35 INFO - ##### 07:11:35 INFO - Running pre-action listener: _resource_record_pre_action 07:11:35 INFO - Running main action method: download_and_extract 07:11:35 INFO - mkdir: /builds/slave/test/build/tests 07:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:35 INFO - https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:11:42 INFO - Downloaded 1361 bytes. 07:11:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:11:42 INFO - Using the following test package requirements: 07:11:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:11:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:11:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'jsshell-linux-x86_64.zip'], 07:11:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:11:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:11:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:11:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:11:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:11:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:42 INFO - https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:46 INFO - Downloaded 23866585 bytes. 07:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:47 INFO - Return code: 0 07:11:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:47 INFO - https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:53 INFO - Downloaded 23866585 bytes. 07:11:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:54 INFO - Return code: 0 07:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:54 INFO - https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:11:55 INFO - Downloaded 10840145 bytes. 07:11:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:11:55 INFO - Return code: 0 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:55 INFO - https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:11:57 INFO - Downloaded 58366069 bytes. 07:11:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:57 INFO - mkdir: /builds/slave/test/properties 07:11:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:57 INFO - Contents: 07:11:57 INFO - build_url:https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:58 INFO - Running post-action listener: _resource_record_post_action 07:11:58 INFO - Running post-action listener: set_extra_try_arguments 07:11:58 INFO - ##### 07:11:58 INFO - ##### Running populate-webroot step. 07:11:58 INFO - ##### 07:11:58 INFO - Running pre-action listener: _resource_record_pre_action 07:11:58 INFO - Running main action method: populate_webroot 07:11:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:58 INFO - '--tppagecycles', 07:11:58 INFO - '7'], 07:11:58 INFO - 'tests': ['tsvgm']}}, 07:11:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['damp', 'tps']}, 07:11:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'tests': ['damp', 'tps']}, 07:11:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['dromaeo_dom']}, 07:11:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['a11yr', 07:11:58 INFO - 'ts_paint', 07:11:58 INFO - 'tpaint', 07:11:58 INFO - 'sessionrestore', 07:11:58 INFO - 'sessionrestore_no_auto_restore', 07:11:58 INFO - 'tabpaint']}, 07:11:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['tsvgx', 07:11:58 INFO - 'tsvgr_opacity', 07:11:58 INFO - 'tart', 07:11:58 INFO - 'tscrollx', 07:11:58 INFO - 'cart']}, 07:11:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:58 INFO - 'tsvgr_opacity', 07:11:58 INFO - 'tart', 07:11:58 INFO - 'tscrollx', 07:11:58 INFO - 'cart']}, 07:11:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'talos_options': ['--disable-e10s'], 07:11:58 INFO - 'tests': ['tp5o']}, 07:11:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'tests': ['tp5o']}, 07:11:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'talos_options': ['--disable-e10s', 07:11:58 INFO - '--xperf_path', 07:11:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:58 INFO - 'tests': ['tp5n']}, 07:11:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:58 INFO - 'talos_options': ['--xperf_path', 07:11:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:58 INFO - 'tests': ['tp5n']}}, 07:11:58 INFO - 'talos.zip': {'path': '', 07:11:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:58 INFO - Running post-action listener: _resource_record_post_action 07:11:58 INFO - ##### 07:11:58 INFO - ##### Running create-virtualenv step. 07:11:58 INFO - ##### 07:11:58 INFO - Running pre-action listener: _resource_record_pre_action 07:11:58 INFO - Running main action method: create_virtualenv 07:11:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:11:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:58 INFO - Using real prefix '/usr' 07:11:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:01 INFO - Installing pip.................done. 07:12:01 INFO - Return code: 0 07:12:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:01 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:12:01 INFO - Using env: {'DISPLAY': ':0', 07:12:01 INFO - 'HOME': '/home/cltbld', 07:12:01 INFO - 'LANG': 'en_US.UTF-8', 07:12:01 INFO - 'LANGUAGE': 'en_US:en', 07:12:01 INFO - 'LOGNAME': 'cltbld', 07:12:01 INFO - 'MAIL': '/var/mail/cltbld', 07:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:01 INFO - 'MOZ_NO_REMOTE': '1', 07:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:01 INFO - 'NO_EM_RESTART': '1', 07:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:01 INFO - 'PWD': '/builds/slave/test', 07:12:01 INFO - 'SHELL': '/bin/bash', 07:12:01 INFO - 'SHLVL': '1', 07:12:01 INFO - 'TERM': 'linux', 07:12:01 INFO - 'TMOUT': '86400', 07:12:01 INFO - 'USER': 'cltbld', 07:12:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:01 INFO - '_': '/tools/buildbot/bin/python'} 07:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:12:01 INFO - Cleaning up... 07:12:01 INFO - Return code: 0 07:12:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:01 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:01 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>=0.7.1'] in /builds/slave/test/build 07:12:01 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>=0.7.1 07:12:01 INFO - Using env: {'DISPLAY': ':0', 07:12:01 INFO - 'HOME': '/home/cltbld', 07:12:01 INFO - 'LANG': 'en_US.UTF-8', 07:12:01 INFO - 'LANGUAGE': 'en_US:en', 07:12:01 INFO - 'LOGNAME': 'cltbld', 07:12:01 INFO - 'MAIL': '/var/mail/cltbld', 07:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:01 INFO - 'MOZ_NO_REMOTE': '1', 07:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:01 INFO - 'NO_EM_RESTART': '1', 07:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:01 INFO - 'PWD': '/builds/slave/test', 07:12:01 INFO - 'SHELL': '/bin/bash', 07:12:01 INFO - 'SHLVL': '1', 07:12:01 INFO - 'TERM': 'linux', 07:12:01 INFO - 'TMOUT': '86400', 07:12:01 INFO - 'USER': 'cltbld', 07:12:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:01 INFO - '_': '/tools/buildbot/bin/python'} 07:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:01 INFO - Downloading/unpacking psutil>=0.7.1 07:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:03 INFO - Installing collected packages: psutil 07:12:03 INFO - Running setup.py install for psutil 07:12:03 INFO - building 'psutil._psutil_linux' extension 07:12:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:12:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:12:03 INFO - building 'psutil._psutil_posix' extension 07:12:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:12:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:03 INFO - Successfully installed psutil 07:12:03 INFO - Cleaning up... 07:12:04 INFO - Return code: 0 07:12:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:04 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.0.0'] in /builds/slave/test/build 07:12:04 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.0.0 07:12:04 INFO - Using env: {'DISPLAY': ':0', 07:12:04 INFO - 'HOME': '/home/cltbld', 07:12:04 INFO - 'LANG': 'en_US.UTF-8', 07:12:04 INFO - 'LANGUAGE': 'en_US:en', 07:12:04 INFO - 'LOGNAME': 'cltbld', 07:12:04 INFO - 'MAIL': '/var/mail/cltbld', 07:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:04 INFO - 'MOZ_NO_REMOTE': '1', 07:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:04 INFO - 'NO_EM_RESTART': '1', 07:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:04 INFO - 'PWD': '/builds/slave/test', 07:12:04 INFO - 'SHELL': '/bin/bash', 07:12:04 INFO - 'SHLVL': '1', 07:12:04 INFO - 'TERM': 'linux', 07:12:04 INFO - 'TMOUT': '86400', 07:12:04 INFO - 'USER': 'cltbld', 07:12:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:04 INFO - '_': '/tools/buildbot/bin/python'} 07:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:06 INFO - Installing collected packages: mozsystemmonitor 07:12:06 INFO - Running setup.py install for mozsystemmonitor 07:12:06 INFO - Successfully installed mozsystemmonitor 07:12:06 INFO - Cleaning up... 07:12:06 INFO - Return code: 0 07:12:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:06 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:06 INFO - Using env: {'DISPLAY': ':0', 07:12:06 INFO - 'HOME': '/home/cltbld', 07:12:06 INFO - 'LANG': 'en_US.UTF-8', 07:12:06 INFO - 'LANGUAGE': 'en_US:en', 07:12:06 INFO - 'LOGNAME': 'cltbld', 07:12:06 INFO - 'MAIL': '/var/mail/cltbld', 07:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:06 INFO - 'MOZ_NO_REMOTE': '1', 07:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:06 INFO - 'NO_EM_RESTART': '1', 07:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:06 INFO - 'PWD': '/builds/slave/test', 07:12:06 INFO - 'SHELL': '/bin/bash', 07:12:06 INFO - 'SHLVL': '1', 07:12:06 INFO - 'TERM': 'linux', 07:12:06 INFO - 'TMOUT': '86400', 07:12:06 INFO - 'USER': 'cltbld', 07:12:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:06 INFO - '_': '/tools/buildbot/bin/python'} 07:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:09 INFO - Downloading docopt-0.6.1.tar.gz 07:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:09 INFO - Running setup.py install for blobuploader 07:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:09 INFO - Running setup.py install for requests 07:12:09 INFO - Running setup.py install for docopt 07:12:09 INFO - Successfully installed blobuploader requests docopt 07:12:09 INFO - Cleaning up... 07:12:09 INFO - Return code: 0 07:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:09 INFO - Using env: {'DISPLAY': ':0', 07:12:09 INFO - 'HOME': '/home/cltbld', 07:12:09 INFO - 'LANG': 'en_US.UTF-8', 07:12:09 INFO - 'LANGUAGE': 'en_US:en', 07:12:09 INFO - 'LOGNAME': 'cltbld', 07:12:09 INFO - 'MAIL': '/var/mail/cltbld', 07:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:09 INFO - 'MOZ_NO_REMOTE': '1', 07:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:09 INFO - 'NO_EM_RESTART': '1', 07:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:09 INFO - 'PWD': '/builds/slave/test', 07:12:09 INFO - 'SHELL': '/bin/bash', 07:12:09 INFO - 'SHLVL': '1', 07:12:09 INFO - 'TERM': 'linux', 07:12:09 INFO - 'TMOUT': '86400', 07:12:09 INFO - 'USER': 'cltbld', 07:12:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:09 INFO - '_': '/tools/buildbot/bin/python'} 07:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 INFO - Running setup.py (path:/tmp/pip-d1wp3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:10 INFO - Running setup.py (path:/tmp/pip-Y5UPlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Running setup.py (path:/tmp/pip-4pHj8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Running setup.py (path:/tmp/pip-B4RC3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Running setup.py (path:/tmp/pip-rayGzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Running setup.py (path:/tmp/pip-35GcTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Running setup.py (path:/tmp/pip-pKjIQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Running setup.py (path:/tmp/pip-RDbeMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Running setup.py (path:/tmp/pip-4RQUOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Running setup.py (path:/tmp/pip-RKNClj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Running setup.py (path:/tmp/pip-L7qe4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 INFO - Running setup.py (path:/tmp/pip-c3v7Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:10 INFO - Running setup.py (path:/tmp/pip-KphEqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:10 INFO - Running setup.py (path:/tmp/pip-VpjyOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:10 INFO - Running setup.py (path:/tmp/pip-BfCl07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Running setup.py (path:/tmp/pip-tDxS8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Running setup.py (path:/tmp/pip-5MXN0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:11 INFO - Running setup.py install for manifestparser 07:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Running setup.py install for mozcrash 07:12:11 INFO - Running setup.py install for mozdebug 07:12:11 INFO - Running setup.py install for mozdevice 07:12:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Running setup.py install for mozfile 07:12:11 INFO - Running setup.py install for mozhttpd 07:12:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Running setup.py install for mozinfo 07:12:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Running setup.py install for mozInstall 07:12:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozleak 07:12:12 INFO - Running setup.py install for mozlog 07:12:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for moznetwork 07:12:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozprocess 07:12:12 INFO - Running setup.py install for mozprofile 07:12:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozrunner 07:12:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozscreenshot 07:12:12 INFO - Running setup.py install for moztest 07:12:12 INFO - Running setup.py install for mozversion 07:12:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:12 INFO - Cleaning up... 07:12:12 INFO - Return code: 0 07:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:12 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:13 INFO - Using env: {'DISPLAY': ':0', 07:12:13 INFO - 'HOME': '/home/cltbld', 07:12:13 INFO - 'LANG': 'en_US.UTF-8', 07:12:13 INFO - 'LANGUAGE': 'en_US:en', 07:12:13 INFO - 'LOGNAME': 'cltbld', 07:12:13 INFO - 'MAIL': '/var/mail/cltbld', 07:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:13 INFO - 'MOZ_NO_REMOTE': '1', 07:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:13 INFO - 'NO_EM_RESTART': '1', 07:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:13 INFO - 'PWD': '/builds/slave/test', 07:12:13 INFO - 'SHELL': '/bin/bash', 07:12:13 INFO - 'SHLVL': '1', 07:12:13 INFO - 'TERM': 'linux', 07:12:13 INFO - 'TMOUT': '86400', 07:12:13 INFO - 'USER': 'cltbld', 07:12:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:13 INFO - '_': '/tools/buildbot/bin/python'} 07:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:13 INFO - Running setup.py (path:/tmp/pip-HHoaPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:13 INFO - Running setup.py (path:/tmp/pip-zzOtGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:13 INFO - Running setup.py (path:/tmp/pip-CPrWat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:13 INFO - Running setup.py (path:/tmp/pip-LlWq4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:13 INFO - Running setup.py (path:/tmp/pip-G6D3Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:13 INFO - Running setup.py (path:/tmp/pip-a8vjjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:13 INFO - Running setup.py (path:/tmp/pip-oCPTp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:13 INFO - Running setup.py (path:/tmp/pip-2CGyhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:13 INFO - Running setup.py (path:/tmp/pip-jFkKsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:13 INFO - Running setup.py (path:/tmp/pip-2VBXtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:13 INFO - Running setup.py (path:/tmp/pip-il_bZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:14 INFO - Running setup.py (path:/tmp/pip-WjV2nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:14 INFO - Running setup.py (path:/tmp/pip-yNXCcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:14 INFO - Running setup.py (path:/tmp/pip-1BCcnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:14 INFO - Running setup.py (path:/tmp/pip-yNudwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:14 INFO - Running setup.py (path:/tmp/pip-9dcg_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:14 INFO - Running setup.py (path:/tmp/pip-buu2b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:16 INFO - Downloading blessings-1.6.tar.gz 07:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:16 INFO - Installing collected packages: blessings 07:12:16 INFO - Running setup.py install for blessings 07:12:16 INFO - Successfully installed blessings 07:12:16 INFO - Cleaning up... 07:12:16 INFO - Return code: 0 07:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:16 INFO - Reading from file tmpfile_stdout 07:12:16 INFO - Current package versions: 07:12:16 INFO - argparse == 1.2.1 07:12:16 INFO - blessings == 1.6 07:12:16 INFO - blobuploader == 1.2.4 07:12:16 INFO - docopt == 0.6.1 07:12:16 INFO - manifestparser == 1.1 07:12:16 INFO - mozInstall == 1.12 07:12:16 INFO - mozcrash == 0.17 07:12:16 INFO - mozdebug == 0.1 07:12:16 INFO - mozdevice == 0.48 07:12:16 INFO - mozfile == 1.2 07:12:16 INFO - mozhttpd == 0.7 07:12:16 INFO - mozinfo == 0.9 07:12:16 INFO - mozleak == 0.1 07:12:16 INFO - mozlog == 3.1 07:12:16 INFO - moznetwork == 0.27 07:12:16 INFO - mozprocess == 0.22 07:12:16 INFO - mozprofile == 0.28 07:12:16 INFO - mozrunner == 6.11 07:12:16 INFO - mozscreenshot == 0.1 07:12:16 INFO - mozsystemmonitor == 0.0 07:12:16 INFO - moztest == 0.7 07:12:16 INFO - mozversion == 1.4 07:12:16 INFO - psutil == 3.1.1 07:12:16 INFO - requests == 1.2.3 07:12:16 INFO - wsgiref == 0.1.2 07:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:16 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:16 INFO - Using env: {'DISPLAY': ':0', 07:12:16 INFO - 'HOME': '/home/cltbld', 07:12:16 INFO - 'LANG': 'en_US.UTF-8', 07:12:16 INFO - 'LANGUAGE': 'en_US:en', 07:12:16 INFO - 'LOGNAME': 'cltbld', 07:12:16 INFO - 'MAIL': '/var/mail/cltbld', 07:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:16 INFO - 'MOZ_NO_REMOTE': '1', 07:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:16 INFO - 'NO_EM_RESTART': '1', 07:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:16 INFO - 'PWD': '/builds/slave/test', 07:12:16 INFO - 'SHELL': '/bin/bash', 07:12:16 INFO - 'SHLVL': '1', 07:12:16 INFO - 'TERM': 'linux', 07:12:16 INFO - 'TMOUT': '86400', 07:12:16 INFO - 'USER': 'cltbld', 07:12:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:16 INFO - '_': '/tools/buildbot/bin/python'} 07:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:17 INFO - Cleaning up... 07:12:17 INFO - Return code: 0 07:12:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:17 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:12:17 INFO - Using env: {'DISPLAY': ':0', 07:12:17 INFO - 'HOME': '/home/cltbld', 07:12:17 INFO - 'LANG': 'en_US.UTF-8', 07:12:17 INFO - 'LANGUAGE': 'en_US:en', 07:12:17 INFO - 'LOGNAME': 'cltbld', 07:12:17 INFO - 'MAIL': '/var/mail/cltbld', 07:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:17 INFO - 'MOZ_NO_REMOTE': '1', 07:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:17 INFO - 'NO_EM_RESTART': '1', 07:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:17 INFO - 'PWD': '/builds/slave/test', 07:12:17 INFO - 'SHELL': '/bin/bash', 07:12:17 INFO - 'SHLVL': '1', 07:12:17 INFO - 'TERM': 'linux', 07:12:17 INFO - 'TMOUT': '86400', 07:12:17 INFO - 'USER': 'cltbld', 07:12:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:17 INFO - '_': '/tools/buildbot/bin/python'} 07:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:17 INFO - Downloading/unpacking jsonschema 07:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:19 INFO - warning: no files found matching '*.txt' 07:12:19 INFO - no previously-included directories found matching 'build' 07:12:19 INFO - no previously-included directories found matching 'dist' 07:12:19 INFO - no previously-included directories found matching '.git*' 07:12:19 INFO - Installing collected packages: jsonschema, functools32 07:12:19 INFO - Running setup.py install for functools32 07:12:19 INFO - warning: no files found matching '*.txt' 07:12:19 INFO - no previously-included directories found matching 'build' 07:12:19 INFO - no previously-included directories found matching 'dist' 07:12:19 INFO - no previously-included directories found matching '.git*' 07:12:19 INFO - Successfully installed jsonschema functools32 07:12:19 INFO - Cleaning up... 07:12:19 INFO - Return code: 0 07:12:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:19 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 0x7fb3c6596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:12:19 INFO - Using env: {'DISPLAY': ':0', 07:12:19 INFO - 'HOME': '/home/cltbld', 07:12:19 INFO - 'LANG': 'en_US.UTF-8', 07:12:19 INFO - 'LANGUAGE': 'en_US:en', 07:12:19 INFO - 'LOGNAME': 'cltbld', 07:12:19 INFO - 'MAIL': '/var/mail/cltbld', 07:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:19 INFO - 'MOZ_NO_REMOTE': '1', 07:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:19 INFO - 'NO_EM_RESTART': '1', 07:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:19 INFO - 'PWD': '/builds/slave/test', 07:12:19 INFO - 'SHELL': '/bin/bash', 07:12:19 INFO - 'SHLVL': '1', 07:12:19 INFO - 'TERM': 'linux', 07:12:19 INFO - 'TMOUT': '86400', 07:12:19 INFO - 'USER': 'cltbld', 07:12:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:19 INFO - '_': '/tools/buildbot/bin/python'} 07:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:19 INFO - Downloading/unpacking flake8 07:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:12:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:22 INFO - no previously-included directories found matching 'docs/_build' 07:12:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:12:22 INFO - Running setup.py install for pep8 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:22 INFO - no previously-included directories found matching 'docs/_build' 07:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:22 INFO - Cleaning up... 07:12:22 INFO - Return code: 0 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - Running post-action listener: _start_resource_monitoring 07:12:22 INFO - Starting resource monitoring. 07:12:22 INFO - ##### 07:12:22 INFO - ##### Running install step. 07:12:22 INFO - ##### 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: install 07:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:23 INFO - Reading from file tmpfile_stdout 07:12:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:23 INFO - Reading from file tmpfile_stdout 07:12:23 INFO - Output received: 07:12:23 INFO - Usage: mozinstall [options] installer 07:12:23 INFO - Options: 07:12:23 INFO - -h, --help show this help message and exit 07:12:23 INFO - -d DEST, --destination=DEST 07:12:23 INFO - Directory to install application into. [default: 07:12:23 INFO - "/builds/slave/test"] 07:12:23 INFO - --app=APP Application being installed. [default: firefox] 07:12:23 INFO - mkdir: /builds/slave/test/build/application 07:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:12:39 INFO - Reading from file tmpfile_stdout 07:12:39 INFO - Output received: 07:12:39 INFO - /builds/slave/test/build/application/firefox/firefox 07:12:39 INFO - Running post-action listener: _resource_record_post_action 07:12:39 INFO - ##### 07:12:39 INFO - ##### Running run-tests step. 07:12:39 INFO - ##### 07:12:39 INFO - Running pre-action listener: _resource_record_pre_action 07:12:39 INFO - Running main action method: run_tests 07:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:12:39 INFO - Python 2.7.3 07:12:39 INFO - Return code: 0 07:12:39 INFO - grabbing minidump binary from tooltool 07:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:39 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d30810>, '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 0x2d31710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d31ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:12:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:12:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:12:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:12:39 INFO - Return code: 0 07:12:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:12:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:12:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:12:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:12:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:12:40 INFO - Return code: 0 07:12:40 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/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:12:40 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/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:12:40 INFO - Using env: {'DISPLAY': ':0', 07:12:40 INFO - 'HOME': '/home/cltbld', 07:12:40 INFO - 'LANG': 'en_US.UTF-8', 07:12:40 INFO - 'LANGUAGE': 'en_US:en', 07:12:40 INFO - 'LOGNAME': 'cltbld', 07:12:40 INFO - 'MAIL': '/var/mail/cltbld', 07:12:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:12:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:40 INFO - 'MOZ_NO_REMOTE': '1', 07:12:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:40 INFO - 'NO_EM_RESTART': '1', 07:12:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:40 INFO - 'PWD': '/builds/slave/test', 07:12:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:12:40 INFO - 'SHELL': '/bin/bash', 07:12:40 INFO - 'SHLVL': '1', 07:12:40 INFO - 'TERM': 'linux', 07:12:40 INFO - 'TMOUT': '86400', 07:12:40 INFO - 'USER': 'cltbld', 07:12:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822', 07:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:40 INFO - '_': '/tools/buildbot/bin/python'} 07:12:40 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/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:12:40 INFO - mozversion application_buildid: 20160427043020 07:12:40 INFO - mozversion application_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 07:12:40 INFO - mozversion application_display_name: Nightly 07:12:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:12:40 INFO - mozversion application_name: Firefox 07:12:40 INFO - mozversion application_remotingname: firefox 07:12:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:12:40 INFO - mozversion application_vendor: Mozilla 07:12:40 INFO - mozversion application_version: 49.0a1 07:12:40 INFO - mozversion platform_buildid: 20160427043020 07:12:40 INFO - mozversion platform_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 07:12:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:12:40 INFO - mozversion platform_version: 49.0a1 07:12:40 INFO - using testdate: 1461766360 07:12:40 INFO - actual date: 1461766360 07:12:40 INFO - starting webserver on 'localhost:56423' 07:12:40 INFO - SUITE-START | Running 2 tests 07:12:40 INFO - TEST-START | dromaeo_css 07:12:40 INFO - operating with platform_type : linux_ 07:12:40 INFO - Initialising browser for dromaeo_css test... 07:12:40 INFO - TEST-INFO | started process 10498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacY6SX/profile http://localhost:56423/getInfo.html) 07:12:45 INFO - PROCESS | 10498 | __metrics Screen width/height:1600/1200 07:12:45 INFO - PROCESS | 10498 | colorDepth:24 07:12:45 INFO - PROCESS | 10498 | Browser inner width/height: 1024/697 07:12:45 INFO - PROCESS | 10498 | __metrics 07:12:46 ERROR - PROCESS | 10498 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:12:46 INFO - TEST-INFO | 10498: exit 0 07:12:46 INFO - Browser initialized. 07:12:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:12:46 INFO - TEST-INFO | started process 10577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacY6SX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:58 INFO - PROCESS | 10577 | RSS: Main: 153845760 07:12:58 INFO - PROCESS | 10577 | 07:13:49 INFO - PROCESS | 10577 | 1461766429688 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:15:57 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56423/tests/dromaeo/cssquery-ext.html) 07:15:58 INFO - PROCESS | 10577 | RSS: Main: 257855488 07:15:58 INFO - PROCESS | 10577 | 07:19:00 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-ext.html (next: http://localhost:56423/tests/dromaeo/cssquery-jquery.html) 07:19:00 INFO - PROCESS | 10577 | RSS: Main: 237035520 07:19:00 INFO - PROCESS | 10577 | 07:22:02 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56423/tests/dromaeo/cssquery-mootools.html) 07:22:03 INFO - PROCESS | 10577 | RSS: Main: 235663360 07:22:03 INFO - PROCESS | 10577 | 07:25:05 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56423/tests/dromaeo/cssquery-prototype.html) 07:25:05 INFO - PROCESS | 10577 | RSS: Main: 225431552 07:25:05 INFO - PROCESS | 10577 | 07:28:08 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56423/tests/dromaeo/cssquery-yui.html) 07:28:09 INFO - PROCESS | 10577 | RSS: Main: 221782016 07:28:09 INFO - PROCESS | 10577 | 07:31:11 INFO - PROCESS | 10577 | Cycle 1(1): loaded http://localhost:56423/tests/dromaeo/cssquery-yui.html (next: http://localhost:56423/tests/dromaeo/cssquery-dojo.html) 07:31:12 INFO - PROCESS | 10577 | RSS: Main: 269508608 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | __start_tp_report 07:31:12 INFO - PROCESS | 10577 | _x_x_mozilla_page_load 07:31:12 INFO - PROCESS | 10577 | _x_x_mozilla_page_load_details 07:31:12 INFO - PROCESS | 10577 | |i|pagename|runs| 07:31:12 INFO - PROCESS | 10577 | |0;dojo.html;3096.396202740465;3134.044116544456;3171.2864605463774;3173.0639461358896;3203.887863924762;5125.179971204608;5216.165413533835;5273.920891186631;5322.574194064475;5352.411234764178;5274.868128296785;5299.33758280215;5313.20301954707;5327.254184414185;5332.57339412847;4643.071385722852;4692.507286734886;4787.928181077269;4848.6848354857;4857.489963553829;4604.355390245369;4787.569118779309;4825.420949486067;4838.177509823338;4842.176829938901;4711.29330600411;4731.905361892777;4748.335233067373;4760.33355330254;4823.614110871139;4737.076270127326;4752.477227505006;4757.690750101232;4766.404199475066;4795.952040479586;4554;4723.834665786681;4726.149293127236;4752.287156926454;4773.0453909218295;5100.719460429675;5116.309298244763;5135.460776618439;5171.379434467888;5176.145935920568;5560.165975103726;5564.8330550083565;5583.162525621149;5588.189712491707;5601.719914004283;5550.972245138789;5640.661560306395;5642.915356269659;5659.801906933238;5740.684262365568;5280.577553795687;5301.814436494704;5303.840884773463;5305.230741542493;5331.44019877915;5764.74058667361;5769.509591684669;5774.82675519735;5780;5862.824115276549;5326.9467305327225;5533.363663178706;5607.915881261784;5616.9157462638095;5652.85867853307;5626.212330273765;5627.6904770237215;5638.04153293941;5644.407337229614;5644.858878527987;5612.326520817446;5623.718814059281;5627.32472103342;5631.662100273997;5632.436756324335;5536.806211782568;5542.418046105101;5575.526080283222;5613.803516876971;5641.12562552805;4236.78816059202;4246.150769846043;4249.277622804131;4253.766042867672;4283.678724095706;3750.212455384345;3807.124361396839;3819.1216020315483;3838.692904567628;3865.9226815464094;5317.9202311965355;5346.144616861284;5356.4107948125675;5391.245225668409;5393.83818485446;5603.159526071122;5609.915851262234;5625.071863142617;5637.154426835926;5656.632318899341;5215.791368345223;5313.0967735485065;5317.8936421271355;5318.175682769177;5330.760115794721;4693.835715749932;4708.670393072452;4711.67018308722;4745.572898439157;4762.8333008345235;5784.248047753849;5788.392218817048;5793.188953546507;5815.360310365856;5845.561582881216;5534.7509362078;5580.358258800127;5616.6068375213345;5617.32592088952;5679.716014199191;5883.55873309512;5895.174675545512;5903.085021821625;5907.675077870758;5909.349971503218;5599.32808063035;5619.100943848965;5631.774729010957;5634.7464364104535;5636.689982050862;5448.591355648421;5619.466150715675;5672.829815105553;5684.118961560965;5730.255066841284;5509.724513774215;5510.256115424367;5521.061419558604;5524.447555244444;5524.558035357242;5470.835874923759;5498.560115190695;5506.732282481109;5508.366537848199;5549.112142057252;5196.298499702643;5366;5439.48324909133;5443.482869127427;5483.616146869681;5547.2511210986;5553.361363443256;5560.944390556043;5561.082421400423;5563.8887222256135;5268.262443258023;5420.159875219348;5470.671759694431;5479.835604931858;5508.091164957737 07:31:12 INFO - PROCESS | 10577 | |1;ext.html;593.8634114153745;635.1806170040647;637.760839685118;646.5797231799331;661.434473525136;30492.695073049264;31176.84411577942;36913.81543092284;37477.81261093698;37507.24985500288;37310.25379492415;37784.24431511375;37929.81035094821;37935.620643793554;37959.430608540824;8474.830503389912;8690.4351217171;8690.4351217171;8693.087225841291;8696.956515217447;8490.957545212264;8611.784705382353;8616.181462761027;8617.784555386103;8629.266512346458;8819.382643214978;8895.73312800617;8904.643814247422;8906.287497000258;8918.687845925393;8802.603882825288;8821.779455513599;8868.290536757044;8888.866667;8889.955550222272;8652.053288010211;8773.605187766565;8776.210141087333;8778.341624378134;8778.47329160246;39100;39106.60893391058;39274.80362598169;39623.20753584941;39636.80181599074;3846.2307538492414;4133.338665813486;4159.812808423628;4217.789110544491;4407.669424793121;27885.86057069722;30061.248468788235;30779.07963495054;31157.221069473217;31355.372892542022;3892.47451594034;4033.8184781684895;4052.8176232069627;4057.82323126293;4084.36692312692;249475;250311;251476;251837.7408112966;252214;44674;52630.473695263325;52922.73538632282;52980;52992.20511692328;50515;51166.48833511692;51579.22631160536;51626.74186629118;51736;16036;16226.594335141479;16235.918820405823;16256.187190640421;16279.51161465158;10773.461326933622;12671.239725616493;12864.935675321563;12940.352982350845;12955.352232388343;14950.102993820406;15013.624659383384;15016.774748378783;15037.323320450607;15216.847831521765;6060.2424696912885;6333.746650133943;6374.649394283359;6399;6427.035944608346;997.5211898288717;1043.155044414027;1131.6122980511116;1158.3455347728507;1192.1059205595802;28929.42141157165;30118.54822177669;30152;30260.69739302579;30712.846435768126;1138.5161306444893;1194.2416565480983;1203.5065623094665;1210.9636710898687;1226.2274766896799;15911.204439778196;16073.598160045858;16123.516294511184;16136.515904522883;16152.273147708382;371435;376037;378343;378662;378768;53161;53300.73349633227;53398;53464.46535534673;53529.57645082615;1300.7983762516826;1378.696686728918;1416.8735854995302;1467.7284702330103;1546.36598994414;29821;31394.21514462157;31742.682573174898;32002.147928641185;32042.19894502656;43416;43885.12229755323;44111.55888441203;44301.11397772091;44330.77834610806;241162;241263;242076;245044;249606;22976.540469190855;23386.883065584563;23453.76546234516;25307.114251001127;25962.572058536964;41304.58695413007;41349;42092.78953605212;42980.35529466998;43761.78119109511;37645.49418023248;37977.4303385455;38016.429753553166;38560.42159367556;38665.80667096759;37862.24275514529;38249;38418.42372364473;38533.4219986706;38704.41943370795;38558.228835423695;38759.418608721455;39654.603453965094;39723.808285751475;39996;32314;33679.4948075784;34543.827280863436;35046;35108.824455877555;25799.355016124748;26305;26323;26496.8675156623;26863.83794798025 07:31:12 INFO - PROCESS | 10577 | |2;jquery.html;394.1211099248674;394.17420504044054;402.52301023287424;406.81489922085444;409.4492907040032;13932.791008134885;15652.530424087296;17448.91275543622;17878.463646090622;18124.63750724985;13942.302884855768;17289.30842766291;17460.47618571442;18018.5495362616;18321.54196145097;5415.187721841716;5565.41563135871;5606.243157173791;5624.29696287964;5625.915611265814;4048.9797551012202;5510.1459273812625;5674.2339784129235;5702.344230413514;5961.523078153759;6283.465905398047;6308.463780578656;6321.968390158066;6336.239651241857;6341.207349081365;6048.485878700316;6201.131841542187;6246.843828904268;6256.405641464076;6272.1219029335925;5397.055515284809;5397.2443857859935;5398.541124004464;5403.054465468566;5450.155225939986;20078.899605502025;20432.182712691476;21263.574728505344;21276.5744685107;21426.5714685707;2480.7147178074574;2512.836665616729;2536.8985240590355;2635.393859412346;2933.559966005116;13081.56102828688;13193.73612527744;13280.86719132806;13299;13873.4450621975;1905.4759941016193;1958.637652034378;2061.5670709151095;2065.452238894734;2092.7070210170587;67990.32009679939;68080.6595967017;68421.65789171073;69150;69847;9816.361936474106;10020.599176033023;10070.899291007143;10090.545925433373;10359.482025898826;13905.79141312881;14042.789358159636;14091.577252682437;14099;14111.929440352938;7066.116735408074;7398.297161769623;7822.960885195537;7860.371170306362;7891.684332626745;7306.611743768667;7441;7632;7716.691332346755;7781.221877812173;6275.560710750295;6424.196975378078;6440.194975628046;6484.1246431731115;6486.35136486357;1873.185164453467;1925.528245579842;1929.2958070304237;1939.660559402099;1964.762199814108;942.2320808541155;1040.8594839696543;1061.4745700878116;1098.9505472253768;1113.4133859250535;17585.384511542034;17753.7336939946;18288.451346459628;18298.81701182998;18612.813871861108;1029.953652085658;1050.2438244463974;1054.0144964458257;1079.7300674831292;1115.2694984784978;9284.675036373694;10475.84286235707;10520.790109137548;10533.104686101615;10556.102731267929;398122;401895;404748;408928;520164;80636.59681701672;89278.55360723154;90378.09621903696;90626.54686726656;90647;1025.8102251083574;1066.594694016269;1069.7165251208437;1078.0836289154156;1090.705509512443;15661.295241714379;15803;15829.920850395674;15849.762253565976;16583.336666533203;33752.66247337593;34066.318673625894;37410.8129459351;37853.43219851759;38090.61909380871;36197;48510.514894852015;49118.75440622774;49504;51083.74458127686;7783;8079.87880181786;8129.4715843469985;8182.877256841271;8200.958995204986;12031.879681203425;12442.31567263773;12707.745845082862;12724.936375318064;13158.671033224246;10811.35131892089;11106.888931110585;11221.71945701364;11344.773104537699;11796.4691588877;10843.512041958289;11005.1746119043;11238.269512481662;11448.255863368855;11503.079753619857;11022.724431889266;11560.30638161713;11648.359340236368;11669.12481563903;11763.647090587296;7996.280334769898;8166.265036146538;8186.09952905168;8247.752567422987;8502.149785021697;11216.943915280697;11296.401827579539;11307.095432365555;11551.942240288745;11597.478113484745 07:31:12 INFO - PROCESS | 10577 | |3;mootools.html;1390.3395886953692;1555.05918919054;1562.7343351630223;1756.947291581252;1827.4060930197688;7164.140303163621;8384.16158384162;8555.95722021389;8571.828563428735;8576.39965202436;8208.630611622477;8420.157984201576;8450.873236901436;8465;8472.661093556266;2020.5756791073893;2108.2937216032647;2225.4436390902274;2249.741279752829;2287.4395773035544;2325.732540757818;2356.2695564375013;2358.481134150493;2358.9056437742556;2361.8346715729904;2206.8124209442217;2233.575620632083;2243.7644047375034;2251.6509940959095;2265.807406370452;1982.5539253667953;2201.438633148537;2244.371575958734;2257.841951063426;2294.816414686821;2242.5402792427512;2270.5685919675375;2271.1029143488395;2274.5678321118935;2276.8064714499287;7912.208779122099;7964.3628509719665;7965.044194696674;7965.6017199139815;7986.081600615946;4770.8330208442885;4889.413270407538;4914.754262286871;4926.704397736147;4927.137750893615;3065.3103051813164;3143.748500119985;3244.772865899388;3248;3252.6259480159847;1031.886492485826;1037.5694086953904;1058.4020028683847;1064.4411683865956;1068.2362111090529;10455.790884182274;10704.625338113128;10738.677839664822;10742.570297188104;10757.623483178051;4183.686223533186;4302.118065796567;4352.194843953878;4414.249577571821;4426.579474949939;9275.07249275067;9423.19902808269;9432.151106400457;9435.198008169245;9440.29197810167;4818.518148185153;4969.229769385751;4998.425181104147;5004.999000199902;5006.0989021975665;4202.117555313418;4673.976630116896;4674.74288914113;4784;4832.492588278251;3905.0432644002403;3999.8800035998966;4001.8399264029113;4004.9599504004586;4010.8796736097966;1237.0660151585496;1268.9682757931125;1284.062634276983;1290.3354772292278;1307.2744626732065;957.5978089202551;966.7486453521994;979.480875136179;990.3364745620452;995.4773743784571;5411.702356370437;5440.945590544044;5513;5536.169574563767;5605.8598535036135;403.3888658682099;422.96404805591254;423.8241129931106;426.15408414297593;429.482473619288;3732.8320225589914;3760.0975765816006;3761.4545890845675;3786.091338078896;3798.981005094957;9992.65025724096;10464.52909619069;10467.790644187073;10471.005254500811;10484.895151048544;10389;10420.843687344695;10427.374357538572;10429.478526073666;10433.843492347622;7567.205443428471;7915;7958.522488650699;7965.283124518821;7982.201779821971;5489.39616642161;5727.341355744143;5775.566832487664;5856.648601083949;5951.404859514188;8919.777005574913;9020.233280171258;9282.72151835446;9335.57989890443;9362.297827662816;9291.070892910655;9378.109079637423;9465.384749991228;9518.857217141609;9522.714318570454;7197.49617526789;7223;7337.04618399626;7348.265173482609;7353.77938661841;7684.193159718149;7711.1132219795445;7773.144954055162;7783.805404864924;7798.493097948615;7090.680919358538;7236.565806051653;7320.341169294789;7353.227911069474;7390.7413240536325;7143.673051804443;7207.963960180376;7284.635768211462;7287.744928927462;7345.853082938418;6603.20761508622;6608.4052435281055;6630.502712296694;6636.13730215069;6670.232923213893;4799.832005879777;4977.427595826382;5023.397192336943;5078.97460512695;5089.974550127374;4884.535969082932;4928.482509336612;5030.346055012825;5068.746562671926;5084.135696931457 07:31:12 INFO - PROCESS | 10577 | |4;prototype.html;333.2884292036503;336.4179968654228;340.22259137869975;340.57598290128783;342.83886573310554;5126;5160.354955630546;5162;5201.945231633507;5219.191025391061;5107.565856902159;5127.33344665193;5136.357955255593;5139.408967968685;5163.380394352674;3850.8459661613574;3880.0705467372095;4019.2363450944226;4047.5952404759582;4053.412255222991;4009.8195581198916;4013.8595149169787;4018.9598104019024;4019.9448419201326;4032.1532478179615;3842.2315536892593;3986.5614782373914;4021.8190181441905;4023.4970628671417;4044.130511939932;3900.941485877714;4016.1566071124953;4019.8593049243136;4021.0244419129926;4037.5760545142925;3581.3195492856275;3592.940082675617;3594.19130695594;3600.4959305697225;3608.2061946371755;4967.726775027372;5010.824621138243;5017.172166592508;5038.521340472649;5054.292399064134;4607.861764147081;4674.696144750615;4678.508756580578;4680.134175177603;4706.670533062653;5364.202991997686;5402.459754024605;5411.485908838654;5420.91868621971;5423.430539793344;4019.738716983416;4030.879073627796;4031.8992025199314;4037.586844604394;4047.413125096874;5365.946340536584;5636.746346414421;5636.859078523029;5665.405132461074;5683.476244728254;3940.4286378474962;3943.684505239574;3955.4066889966734;3964.861229856941;3967.345388010946;3988.720789544762;3993.2612466693754;3997.620226078518;3999.7000224983244;4018.296798060386;4442.600165985077;4589.609883159902;4592.931106033412;4609.723416595015;4611.262198048364;5320.893582128413;5325.786968521215;5364.946350536523;5371.5702743781185;5409.513143817076;1446.7251222267735;1453.8328092269312;1464.5386703188462;1477.5493474490384;1481.4518628107453;921.8202450522218;975.4196253229459;975.531744762518;995.1541189988452;1007.1338648762058;5514.5864060194845;5532.972335138298;5545.085060964896;5550.250716153349;5562.666240025612;5866.8533286667325;5867.9413205867395;5877.353491115974;5880.8235752927485;5895.64626122434;5385.784568617211;5514.503694667499;5528.226048353234;5551.750171242304;5558.304717061254;3095.0250671038552;3103.8758449662214;3128.530720391959;3131;3131.1076343242066;5877.882442351129;6102.328743838174;6105.534671678765;6106.297775755756;6108.267007959073;5917.822465326047;5987;6019.939800601938;6030.819075427744;6032.969835150796;6003.249593800775;6012.7294271757;6060.2424696912885;6060.606060606046;6067.180930574316;5697.069022374549;5881.735321910439;5908.911366329423;5911.586188966731;5913.2608423947;5796.710164491843;5825.650460972186;5829.125631155191;5842.853928651818;5868.3251426086545;5492.176173573996;5764.538836893123;6002.169338351845;6046.969765151146;6095.116208149705;3889.8833035008997;3913.6673382762783;3916.7845768483007;3930.3318435866545;3942.9605703942593;5589.385167631639;5622.116590942081;5626.409227031267;5633.873225355027;5646.689432081275;5250.369955605352;5438.782448702166;5446.774475743085;5449.3188351456065;5497.45025497463;5441.619086664054;5442.156465747816;5442.673439593637;5467.535259502987;5474.206240095244;5086.109930762028;5198.428172901054;5364.865878353073;5378.946210538001;5390.137577987503;5405.8107966221;5417.539509141767;5428.6199966002005;5464.562834973272;5465.972670136783;5338.8932221356135;5365.973170134281;5369.3556773187465;5378.677279363251;5384.219288203267 07:31:12 INFO - PROCESS | 10577 | |5;yui.html;750.6209364271045;754.5585832288111;812.1513018895254;834.4659417972498;865.1348651348651;13861.1683299002;15338.616534586641;15671.84328156718;15715.842841571566;15753.527394178165;14231.359588818503;14540.491082812103;14553.854461455383;14717.558473245794;14773.704525909476;690.5787469643514;804.7585724282721;820.9794755131124;830.0578843013193;831.2601784411878;817.6606708216083;823.9629216685233;824.5094168969454;826.6445428465757;827.9254867061964;871.0114020586616;872.9912700873006;874.7594411536815;875.0374587953232;875.4965894610592;713.5896859305919;853.7012045783988;855.6235256487125;860.862262038074;888.7955770172896;615.5352708704944;618.1253526260336;618.6133666458463;625.6183727925961;626.1703243202729;14475.131492110508;14500.564983050524;14511;14518;14527;13094.345282735825;13463.528776492776;13471.595852124452;13503.392347344394;13596;12230.341422051579;12274;12542.435590398454;12549.02349166104;12746.29895355755;4448.7108337957925;4449.065696203768;4472.351509031172;4495.797689103998;4573.908521829545;55452.72273638606;55503.72248138733;55533.44466555323;55693.443065569234;56342.718286408715;10851;11065.778684426266;11148;11155.776884462266;11546.364949927667;20674;20814.37556873296;20903.68644470334;20991.895040524698;21026.789732102483;7943.205679432011;8060.879086813702;8065.6370463329295;8070.556119413372;8367.456115352483;4557.430321209848;4600.4479462464715;4616.60758835496;4700.88247793801;4716.716996980193;3524.4713293006253;3592.2995015971633;3614.403623402162;3615.6384361563632;3618.1135621772833;569.5842035314244;622.0606883605788;634.9428551430393;636.7707625254905;644.6390021587926;682.6518475577392;732.8204589875514;742.1539445032668;762.6720510180564;764.5947647746704;9683.41899486033;9798.608055677692;9830.557624906896;9846.113849753556;9953.751156221007;663.7477758451854;694.2918223412091;761.8019314978035;762.6949220311809;783.1620166421874;4283.443152390231;4436.423264975532;4466.865994020184;4497.190505709003;4612.07758448305;65199.48005199537;67331;68024.3197568018;68094.65952670205;68503.31496684969;60042;60240.397596024355;60661.69669151626;61111.69444152751;62057;54408.45591544034;54889.451105489235;55014.449855501734;55602.44397555973;56395.71802140963;8641.265492432962;8697.6955806549;8759.386842921189;8813.383063185516;8833.070858318079;35484.11289717778;35969.46045809367;36532;36566;36965.260694785415;45222;47643;47902.76048619874;48144.03711925812;48548.514514854396;11590.710232243924;12151.453184606891;12483.12618116723;12505.312207828656;12525.56160534377;12400.937995309965;12681.80977285323;13286.734265314446;13381.933090334485;13597.86402135966;12274.324912129918;12380.566680166152;12452.128351015343;12904.806427903777;13113.344332783132;13100.344982750634;13211.14127581704;13465.259410732504;13474.326283685581;14284.857151428352;12945.611631651065;13201.867981320063;13213.603591892259;13324.133931294435;14315.498957536436;10853.674389768319;10926.672199834018;11193.720156995814;11254.60608878718;11938;10383.84424233622;11017.394043327695;11037.503312350804;11140.554377824796;11307.265027773497 07:31:12 INFO - PROCESS | 10577 | __end_tp_report 07:31:12 INFO - PROCESS | 10577 | __start_cc_report 07:31:12 INFO - PROCESS | 10577 | _x_x_mozilla_cycle_collect,839 07:31:12 INFO - PROCESS | 10577 | __end_cc_report 07:31:12 INFO - PROCESS | 10577 | __startTimestamp1461767472031__endTimestamp 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | ------- Summary: start ------- 07:31:12 INFO - PROCESS | 10577 | Number of tests: 6 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#0] dojo.html Cycles:165 Average:5223.92 Median:5448.59 stddev:596.22 (10.9%) stddev-sans-first:574.22 07:31:12 INFO - PROCESS | 10577 | Values: 3096.4 3134.0 3171.3 3173.1 3203.9 5125.2 5216.2 5273.9 5322.6 5352.4 5274.9 5299.3 5313.2 5327.3 5332.6 4643.1 4692.5 4787.9 4848.7 4857.5 4604.4 4787.6 4825.4 4838.2 4842.2 4711.3 4731.9 4748.3 4760.3 4823.6 4737.1 4752.5 4757.7 4766.4 4796.0 4554.0 4723.8 4726.1 4752.3 4773.0 5100.7 5116.3 5135.5 5171.4 5176.1 5560.2 5564.8 5583.2 5588.2 5601.7 5551.0 5640.7 5642.9 5659.8 5740.7 5280.6 5301.8 5303.8 5305.2 5331.4 5764.7 5769.5 5774.8 5780.0 5862.8 5326.9 5533.4 5607.9 5616.9 5652.9 5626.2 5627.7 5638.0 5644.4 5644.9 5612.3 5623.7 5627.3 5631.7 5632.4 5536.8 5542.4 5575.5 5613.8 5641.1 4236.8 4246.2 4249.3 4253.8 4283.7 3750.2 3807.1 3819.1 3838.7 3865.9 5317.9 5346.1 5356.4 5391.2 5393.8 5603.2 5609.9 5625.1 5637.2 5656.6 5215.8 5313.1 5317.9 5318.2 5330.8 4693.8 4708.7 4711.7 4745.6 4762.8 5784.2 5788.4 5793.2 5815.4 5845.6 5534.8 5580.4 5616.6 5617.3 5679.7 5883.6 5895.2 5903.1 5907.7 5909.3 5599.3 5619.1 5631.8 5634.7 5636.7 5448.6 5619.5 5672.8 5684.1 5730.3 5509.7 5510.3 5521.1 5524.4 5524.6 5470.8 5498.6 5506.7 5508.4 5549.1 5196.3 5366.0 5439.5 5443.5 5483.6 5547.3 5553.4 5560.9 5561.1 5563.9 5268.3 5420.2 5470.7 5479.8 5508.1 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#1] ext.html Cycles:180 Average:45562.64 Median:37968.43 stddev:77813.64 (204.9%) stddev-sans-first:77958.67 07:31:12 INFO - PROCESS | 10577 | Values: 593.9 635.2 637.8 646.6 661.4 30492.7 31176.8 36913.8 37477.8 37507.2 37310.3 37784.2 37929.8 37935.6 37959.4 8474.8 8690.4 8690.4 8693.1 8697.0 8491.0 8611.8 8616.2 8617.8 8629.3 8819.4 8895.7 8904.6 8906.3 8918.7 8802.6 8821.8 8868.3 8888.9 8890.0 8652.1 8773.6 8776.2 8778.3 8778.5 39100.0 39106.6 39274.8 39623.2 39636.8 3846.2 4133.3 4159.8 4217.8 4407.7 27885.9 30061.2 30779.1 31157.2 31355.4 3892.5 4033.8 4052.8 4057.8 4084.4 249475.0 250311.0 251476.0 251837.7 252214.0 44674.0 52630.5 52922.7 52980.0 52992.2 50515.0 51166.5 51579.2 51626.7 51736.0 16036.0 16226.6 16235.9 16256.2 16279.5 10773.5 12671.2 12864.9 12940.4 12955.4 14950.1 15013.6 15016.8 15037.3 15216.8 6060.2 6333.7 6374.6 6399.0 6427.0 997.5 1043.2 1131.6 1158.3 1192.1 28929.4 30118.5 30152.0 30260.7 30712.8 1138.5 1194.2 1203.5 1211.0 1226.2 15911.2 16073.6 16123.5 16136.5 16152.3 371435.0 376037.0 378343.0 378662.0 378768.0 53161.0 53300.7 53398.0 53464.5 53529.6 1300.8 1378.7 1416.9 1467.7 1546.4 29821.0 31394.2 31742.7 32002.1 32042.2 43416.0 43885.1 44111.6 44301.1 44330.8 241162.0 241263.0 242076.0 245044.0 249606.0 22976.5 23386.9 23453.8 25307.1 25962.6 41304.6 41349.0 42092.8 42980.4 43761.8 37645.5 37977.4 38016.4 38560.4 38665.8 37862.2 38249.0 38418.4 38533.4 38704.4 38558.2 38759.4 39654.6 39723.8 39996.0 32314.0 33679.5 34543.8 35046.0 35108.8 25799.4 26305.0 26323.0 26496.9 26863.8 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#2] jquery.html Cycles:180 Average:26059.34 Median:21351.57 stddev:70766.03 (331.4%) stddev-sans-first:70938.31 07:31:12 INFO - PROCESS | 10577 | Values: 394.1 394.2 402.5 406.8 409.4 13932.8 15652.5 17448.9 17878.5 18124.6 13942.3 17289.3 17460.5 18018.5 18321.5 5415.2 5565.4 5606.2 5624.3 5625.9 4049.0 5510.1 5674.2 5702.3 5961.5 6283.5 6308.5 6322.0 6336.2 6341.2 6048.5 6201.1 6246.8 6256.4 6272.1 5397.1 5397.2 5398.5 5403.1 5450.2 20078.9 20432.2 21263.6 21276.6 21426.6 2480.7 2512.8 2536.9 2635.4 2933.6 13081.6 13193.7 13280.9 13299.0 13873.4 1905.5 1958.6 2061.6 2065.5 2092.7 67990.3 68080.7 68421.7 69150.0 69847.0 9816.4 10020.6 10070.9 10090.5 10359.5 13905.8 14042.8 14091.6 14099.0 14111.9 7066.1 7398.3 7823.0 7860.4 7891.7 7306.6 7441.0 7632.0 7716.7 7781.2 6275.6 6424.2 6440.2 6484.1 6486.4 1873.2 1925.5 1929.3 1939.7 1964.8 942.2 1040.9 1061.5 1099.0 1113.4 17585.4 17753.7 18288.5 18298.8 18612.8 1030.0 1050.2 1054.0 1079.7 1115.3 9284.7 10475.8 10520.8 10533.1 10556.1 398122.0 401895.0 404748.0 408928.0 520164.0 80636.6 89278.6 90378.1 90626.5 90647.0 1025.8 1066.6 1069.7 1078.1 1090.7 15661.3 15803.0 15829.9 15849.8 16583.3 33752.7 34066.3 37410.8 37853.4 38090.6 36197.0 48510.5 49118.8 49504.0 51083.7 7783.0 8079.9 8129.5 8182.9 8201.0 12031.9 12442.3 12707.7 12724.9 13158.7 10811.4 11106.9 11221.7 11344.8 11796.5 10843.5 11005.2 11238.3 11448.3 11503.1 11022.7 11560.3 11648.4 11669.1 11763.6 7996.3 8166.3 8186.1 8247.8 8502.1 11216.9 11296.4 11307.1 11551.9 11597.5 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#3] mootools.html Cycles:180 Average:5438.47 Median:4926.92 stddev:3031.02 (61.5%) stddev-sans-first:3024.25 07:31:12 INFO - PROCESS | 10577 | Values: 1390.3 1555.1 1562.7 1756.9 1827.4 7164.1 8384.2 8556.0 8571.8 8576.4 8208.6 8420.2 8450.9 8465.0 8472.7 2020.6 2108.3 2225.4 2249.7 2287.4 2325.7 2356.3 2358.5 2358.9 2361.8 2206.8 2233.6 2243.8 2251.7 2265.8 1982.6 2201.4 2244.4 2257.8 2294.8 2242.5 2270.6 2271.1 2274.6 2276.8 7912.2 7964.4 7965.0 7965.6 7986.1 4770.8 4889.4 4914.8 4926.7 4927.1 3065.3 3143.7 3244.8 3248.0 3252.6 1031.9 1037.6 1058.4 1064.4 1068.2 10455.8 10704.6 10738.7 10742.6 10757.6 4183.7 4302.1 4352.2 4414.2 4426.6 9275.1 9423.2 9432.2 9435.2 9440.3 4818.5 4969.2 4998.4 5005.0 5006.1 4202.1 4674.0 4674.7 4784.0 4832.5 3905.0 3999.9 4001.8 4005.0 4010.9 1237.1 1269.0 1284.1 1290.3 1307.3 957.6 966.7 979.5 990.3 995.5 5411.7 5440.9 5513.0 5536.2 5605.9 403.4 423.0 423.8 426.2 429.5 3732.8 3760.1 3761.5 3786.1 3799.0 9992.7 10464.5 10467.8 10471.0 10484.9 10389.0 10420.8 10427.4 10429.5 10433.8 7567.2 7915.0 7958.5 7965.3 7982.2 5489.4 5727.3 5775.6 5856.6 5951.4 8919.8 9020.2 9282.7 9335.6 9362.3 9291.1 9378.1 9465.4 9518.9 9522.7 7197.5 7223.0 7337.0 7348.3 7353.8 7684.2 7711.1 7773.1 7783.8 7798.5 7090.7 7236.6 7320.3 7353.2 7390.7 7143.7 7208.0 7284.6 7287.7 7345.9 6603.2 6608.4 6630.5 6636.1 6670.2 4799.8 4977.4 5023.4 5079.0 5090.0 4884.5 4928.5 5030.3 5068.7 5084.1 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#4] prototype.html Cycles:180 Average:4652.16 Median:5332.34 stddev:1387.09 (26.0%) stddev-sans-first:1352.57 07:31:12 INFO - PROCESS | 10577 | Values: 333.3 336.4 340.2 340.6 342.8 5126.0 5160.4 5162.0 5201.9 5219.2 5107.6 5127.3 5136.4 5139.4 5163.4 3850.8 3880.1 4019.2 4047.6 4053.4 4009.8 4013.9 4019.0 4019.9 4032.2 3842.2 3986.6 4021.8 4023.5 4044.1 3900.9 4016.2 4019.9 4021.0 4037.6 3581.3 3592.9 3594.2 3600.5 3608.2 4967.7 5010.8 5017.2 5038.5 5054.3 4607.9 4674.7 4678.5 4680.1 4706.7 5364.2 5402.5 5411.5 5420.9 5423.4 4019.7 4030.9 4031.9 4037.6 4047.4 5365.9 5636.7 5636.9 5665.4 5683.5 3940.4 3943.7 3955.4 3964.9 3967.3 3988.7 3993.3 3997.6 3999.7 4018.3 4442.6 4589.6 4592.9 4609.7 4611.3 5320.9 5325.8 5364.9 5371.6 5409.5 1446.7 1453.8 1464.5 1477.5 1481.5 921.8 975.4 975.5 995.2 1007.1 5514.6 5533.0 5545.1 5550.3 5562.7 5866.9 5867.9 5877.4 5880.8 5895.6 5385.8 5514.5 5528.2 5551.8 5558.3 3095.0 3103.9 3128.5 3131.0 3131.1 5877.9 6102.3 6105.5 6106.3 6108.3 5917.8 5987.0 6019.9 6030.8 6033.0 6003.2 6012.7 6060.2 6060.6 6067.2 5697.1 5881.7 5908.9 5911.6 5913.3 5796.7 5825.7 5829.1 5842.9 5868.3 5492.2 5764.5 6002.2 6047.0 6095.1 3889.9 3913.7 3916.8 3930.3 3943.0 5589.4 5622.1 5626.4 5633.9 5646.7 5250.4 5438.8 5446.8 5449.3 5497.5 5441.6 5442.2 5442.7 5467.5 5474.2 5086.1 5198.4 5364.9 5378.9 5390.1 5405.8 5417.5 5428.6 5464.6 5466.0 5338.9 5366.0 5369.4 5378.7 5384.2 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - PROCESS | 10577 | [#5] yui.html Cycles:180 Average:15640.09 Median:4587.18 stddev:18411.63 (401.4%) stddev-sans-first:18429.33 07:31:12 INFO - PROCESS | 10577 | Values: 750.6 754.6 812.2 834.5 865.1 13861.2 15338.6 15671.8 15715.8 15753.5 14231.4 14540.5 14553.9 14717.6 14773.7 690.6 804.8 821.0 830.1 831.3 817.7 824.0 824.5 826.6 827.9 871.0 873.0 874.8 875.0 875.5 713.6 853.7 855.6 860.9 888.8 615.5 618.1 618.6 625.6 626.2 14475.1 14500.6 14511.0 14518.0 14527.0 13094.3 13463.5 13471.6 13503.4 13596.0 12230.3 12274.0 12542.4 12549.0 12746.3 4448.7 4449.1 4472.4 4495.8 4573.9 55452.7 55503.7 55533.4 55693.4 56342.7 10851.0 11065.8 11148.0 11155.8 11546.4 20674.0 20814.4 20903.7 20991.9 21026.8 7943.2 8060.9 8065.6 8070.6 8367.5 4557.4 4600.4 4616.6 4700.9 4716.7 3524.5 3592.3 3614.4 3615.6 3618.1 569.6 622.1 634.9 636.8 644.6 682.7 732.8 742.2 762.7 764.6 9683.4 9798.6 9830.6 9846.1 9953.8 663.7 694.3 761.8 762.7 783.2 4283.4 4436.4 4466.9 4497.2 4612.1 65199.5 67331.0 68024.3 68094.7 68503.3 60042.0 60240.4 60661.7 61111.7 62057.0 54408.5 54889.5 55014.4 55602.4 56395.7 8641.3 8697.7 8759.4 8813.4 8833.1 35484.1 35969.5 36532.0 36566.0 36965.3 45222.0 47643.0 47902.8 48144.0 48548.5 11590.7 12151.5 12483.1 12505.3 12525.6 12400.9 12681.8 13286.7 13381.9 13597.9 12274.3 12380.6 12452.1 12904.8 13113.3 13100.3 13211.1 13465.3 13474.3 14284.9 12945.6 13201.9 13213.6 13324.1 14315.5 10853.7 10926.7 11193.7 11254.6 11938.0 10383.8 11017.4 11037.5 11140.6 11307.3 07:31:12 INFO - PROCESS | 10577 | -------- Summary: end -------- 07:31:12 INFO - PROCESS | 10577 | 07:31:12 INFO - TEST-INFO | 10577: exit 0 07:31:12 INFO - TEST-OK | dromaeo_css | took 1111878ms 07:31:12 INFO - TEST-START | kraken 07:31:12 INFO - operating with platform_type : linux_ 07:31:12 INFO - Initialising browser for kraken test... 07:31:12 INFO - TEST-INFO | started process 10764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZfjsRs/profile http://localhost:56423/getInfo.html) 07:31:16 INFO - PROCESS | 10764 | __metrics Screen width/height:1600/1200 07:31:16 INFO - PROCESS | 10764 | colorDepth:24 07:31:16 INFO - PROCESS | 10764 | Browser inner width/height: 1024/697 07:31:16 INFO - PROCESS | 10764 | __metrics 07:31:17 ERROR - PROCESS | 10764 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:31:18 INFO - TEST-INFO | 10764: exit 0 07:31:18 INFO - Browser initialized. 07:31:18 INFO - Running cycle 1/1 for kraken test... 07:31:18 INFO - TEST-INFO | started process 10844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZfjsRs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:30 INFO - PROCESS | 10844 | RSS: Main: 154656768 07:31:30 INFO - PROCESS | 10844 | 07:31:32 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56423/tests/kraken/driver.html?testName=audio-beat-detection) 07:31:33 INFO - PROCESS | 10844 | RSS: Main: 209735680 07:31:33 INFO - PROCESS | 10844 | 07:31:36 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56423/tests/kraken/driver.html?testName=audio-dft) 07:31:36 INFO - PROCESS | 10844 | RSS: Main: 194506752 07:31:36 INFO - PROCESS | 10844 | 07:31:39 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56423/tests/kraken/driver.html?testName=audio-fft) 07:31:40 INFO - PROCESS | 10844 | RSS: Main: 264335360 07:31:40 INFO - PROCESS | 10844 | 07:31:42 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56423/tests/kraken/driver.html?testName=audio-oscillator) 07:31:43 INFO - PROCESS | 10844 | RSS: Main: 173559808 07:31:43 INFO - PROCESS | 10844 | 07:31:45 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:31:45 INFO - PROCESS | 10844 | RSS: Main: 178061312 07:31:45 INFO - PROCESS | 10844 | 07:31:48 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56423/tests/kraken/driver.html?testName=imaging-darkroom) 07:31:49 INFO - PROCESS | 10844 | RSS: Main: 214716416 07:31:49 INFO - PROCESS | 10844 | 07:31:52 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56423/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:53 INFO - PROCESS | 10844 | RSS: Main: 214704128 07:31:53 INFO - PROCESS | 10844 | 07:31:56 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56423/tests/kraken/driver.html?testName=json-parse-financial) 07:31:56 INFO - PROCESS | 10844 | RSS: Main: 215220224 07:31:56 INFO - PROCESS | 10844 | 07:31:58 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:58 INFO - PROCESS | 10844 | RSS: Main: 202268672 07:31:58 INFO - PROCESS | 10844 | 07:32:00 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:01 INFO - PROCESS | 10844 | RSS: Main: 204427264 07:32:01 INFO - PROCESS | 10844 | 07:32:03 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:03 INFO - PROCESS | 10844 | RSS: Main: 216150016 07:32:03 INFO - PROCESS | 10844 | 07:32:06 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:07 INFO - PROCESS | 10844 | RSS: Main: 222785536 07:32:07 INFO - PROCESS | 10844 | 07:32:10 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:10 INFO - PROCESS | 10844 | RSS: Main: 221474816 07:32:10 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:56423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56423/tests/kraken/driver.html?testName=ai-astar) 07:32:12 INFO - PROCESS | 10844 | RSS: Main: 284991488 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | __start_tp_report 07:32:12 INFO - PROCESS | 10844 | _x_x_mozilla_page_load 07:32:12 INFO - PROCESS | 10844 | _x_x_mozilla_page_load_details 07:32:12 INFO - PROCESS | 10844 | |i|pagename|runs| 07:32:12 INFO - PROCESS | 10844 | |0;ai-astar;110;111;106;109;113;112;101;112;111;112 07:32:12 INFO - PROCESS | 10844 | |1;audio-beat-detection;153;126;155;182;127;154;161;135;199;128 07:32:12 INFO - PROCESS | 10844 | |2;audio-dft;161;160;160;160;160;160;160;161;161;162 07:32:12 INFO - PROCESS | 10844 | |3;audio-fft;76;72;116;114;76;72;73;117;111;75 07:32:12 INFO - PROCESS | 10844 | |4;audio-oscillator;92;92;155;92;92;93;153;93;93;146 07:32:12 INFO - PROCESS | 10844 | |5;imaging-gaussian-blur;117;122;116;116;117;118;117;116;116;117 07:32:12 INFO - PROCESS | 10844 | |6;imaging-darkroom;146;145;145;144;146;145;148;146;145;145 07:32:12 INFO - PROCESS | 10844 | |7;imaging-desaturate;95;94;94;95;95;94;95;94;95;95 07:32:12 INFO - PROCESS | 10844 | |8;json-parse-financial;56;58;58;56;57;58;57;76;61;53 07:32:12 INFO - PROCESS | 10844 | |9;json-stringify-tinderbox;60;59;61;60;61;59;61;60;60;60 07:32:12 INFO - PROCESS | 10844 | |10;stanford-crypto-aes;76;77;76;75;76;76;78;77;84;80 07:32:12 INFO - PROCESS | 10844 | |11;stanford-crypto-ccm;129;126;132;128;126;122;134;125;157;136 07:32:12 INFO - PROCESS | 10844 | |12;stanford-crypto-pbkdf2;200;201;196;199;204;198;198;199;195;206 07:32:12 INFO - PROCESS | 10844 | |13;stanford-crypto-sha256-iterative;72;72;70;71;68;71;69;67;70;68 07:32:12 INFO - PROCESS | 10844 | __end_tp_report 07:32:12 INFO - PROCESS | 10844 | __start_cc_report 07:32:12 INFO - PROCESS | 10844 | _x_x_mozilla_cycle_collect,1648 07:32:12 INFO - PROCESS | 10844 | __end_cc_report 07:32:12 INFO - PROCESS | 10844 | __startTimestamp1461767532852__endTimestamp 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | ------- Summary: start ------- 07:32:12 INFO - PROCESS | 10844 | Number of tests: 14 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:3.87 07:32:12 INFO - PROCESS | 10844 | Values: 110.0 111.0 106.0 109.0 113.0 112.0 101.0 112.0 111.0 112.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:154.50 stddev:24.43 (15.8%) stddev-sans-first:25.91 07:32:12 INFO - PROCESS | 10844 | Values: 153.0 126.0 155.0 182.0 127.0 154.0 161.0 135.0 199.0 128.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 07:32:12 INFO - PROCESS | 10844 | Values: 161.0 160.0 160.0 160.0 160.0 160.0 160.0 161.0 161.0 162.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#3] audio-fft Cycles:10 Average:90.20 Median:72.50 stddev:21.02 (29.0%) stddev-sans-first:21.66 07:32:12 INFO - PROCESS | 10844 | Values: 76.0 72.0 116.0 114.0 76.0 72.0 73.0 117.0 111.0 75.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:28.54 (31.0%) stddev-sans-first:29.51 07:32:12 INFO - PROCESS | 10844 | Values: 92.0 92.0 155.0 92.0 92.0 93.0 153.0 93.0 93.0 146.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:1.81 (1.6%) stddev-sans-first:1.92 07:32:12 INFO - PROCESS | 10844 | Values: 117.0 122.0 116.0 116.0 117.0 118.0 117.0 116.0 116.0 117.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 07:32:12 INFO - PROCESS | 10844 | Values: 146.0 145.0 145.0 144.0 146.0 145.0 148.0 146.0 145.0 145.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:32:12 INFO - PROCESS | 10844 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:6.31 (10.9%) stddev-sans-first:6.60 07:32:12 INFO - PROCESS | 10844 | Values: 56.0 58.0 58.0 56.0 57.0 58.0 57.0 76.0 61.0 53.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 07:32:12 INFO - PROCESS | 10844 | Values: 60.0 59.0 61.0 60.0 61.0 59.0 61.0 60.0 60.0 60.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.68 (3.5%) stddev-sans-first:2.78 07:32:12 INFO - PROCESS | 10844 | Values: 76.0 77.0 76.0 75.0 76.0 76.0 78.0 77.0 84.0 80.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:130.50 stddev:9.94 (7.6%) stddev-sans-first:10.50 07:32:12 INFO - PROCESS | 10844 | Values: 129.0 126.0 132.0 128.0 126.0 122.0 134.0 125.0 157.0 136.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.60 Median:199.50 stddev:3.37 (1.7%) stddev-sans-first:3.57 07:32:12 INFO - PROCESS | 10844 | Values: 200.0 201.0 196.0 199.0 204.0 198.0 198.0 199.0 195.0 206.0 07:32:12 INFO - PROCESS | 10844 | 07:32:12 INFO - PROCESS | 10844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:1.75 (2.5%) stddev-sans-first:1.67 07:32:12 INFO - PROCESS | 10844 | Values: 72.0 72.0 70.0 71.0 68.0 71.0 69.0 67.0 70.0 68.0 07:32:12 INFO - PROCESS | 10844 | -------- Summary: end -------- 07:32:12 INFO - PROCESS | 10844 | 07:32:13 INFO - TEST-INFO | 10844: exit 0 07:32:13 INFO - TEST-OK | kraken | took 61007ms 07:32:13 INFO - SUITE-END | took 1172s 07:32:14 INFO - Completed test suite (00:19:33) 07:32:14 INFO - javascript benchmark 07:32:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.396202740465, 3134.044116544456, 3171.2864605463774, 3173.0639461358896, 3203.887863924762, 5125.179971204608, 5216.165413533835, 5273.920891186631, 5322.574194064475, 5352.411234764178, 5274.868128296785, 5299.33758280215, 5313.20301954707, 5327.254184414185, 5332.57339412847, 4643.071385722852, 4692.507286734886, 4787.928181077269, 4848.6848354857, 4857.489963553829, 4604.355390245369, 4787.569118779309, 4825.420949486067, 4838.177509823338, 4842.176829938901, 4711.29330600411, 4731.905361892777, 4748.335233067373, 4760.33355330254, 4823.614110871139, 4737.076270127326, 4752.477227505006, 4757.690750101232, 4766.404199475066, 4795.952040479586, 4554.0, 4723.834665786681, 4726.149293127236, 4752.287156926454, 4773.0453909218295, 5100.719460429675, 5116.309298244763, 5135.460776618439, 5171.379434467888, 5176.145935920568, 5560.165975103726, 5564.8330550083565, 5583.162525621149, 5588.189712491707, 5601.719914004283, 5550.972245138789, 5640.661560306395, 5642.915356269659, 5659.801906933238, 5740.684262365568, 5280.577553795687, 5301.814436494704, 5303.840884773463, 5305.230741542493, 5331.44019877915, 5764.74058667361, 5769.509591684669, 5774.82675519735, 5780.0, 5862.824115276549, 5326.9467305327225, 5533.363663178706, 5607.915881261784, 5616.9157462638095, 5652.85867853307, 5626.212330273765, 5627.6904770237215, 5638.04153293941, 5644.407337229614, 5644.858878527987, 5612.326520817446, 5623.718814059281, 5627.32472103342, 5631.662100273997, 5632.436756324335, 5536.806211782568, 5542.418046105101, 5575.526080283222, 5613.803516876971, 5641.12562552805, 4236.78816059202, 4246.150769846043, 4249.277622804131, 4253.766042867672, 4283.678724095706, 3750.212455384345, 3807.124361396839, 3819.1216020315483, 3838.692904567628, 3865.9226815464094, 5317.9202311965355, 5346.144616861284, 5356.4107948125675, 5391.245225668409, 5393.83818485446, 5603.159526071122, 5609.915851262234, 5625.071863142617, 5637.154426835926, 5656.632318899341, 5215.791368345223, 5313.0967735485065, 5317.8936421271355, 5318.175682769177, 5330.760115794721, 4693.835715749932, 4708.670393072452, 4711.67018308722, 4745.572898439157, 4762.8333008345235, 5784.248047753849, 5788.392218817048, 5793.188953546507, 5815.360310365856, 5845.561582881216, 5534.7509362078, 5580.358258800127, 5616.6068375213345, 5617.32592088952, 5679.716014199191, 5883.55873309512, 5895.174675545512, 5903.085021821625, 5907.675077870758, 5909.349971503218, 5599.32808063035, 5619.100943848965, 5631.774729010957, 5634.7464364104535, 5636.689982050862, 5448.591355648421, 5619.466150715675, 5672.829815105553, 5684.118961560965, 5730.255066841284, 5509.724513774215, 5510.256115424367, 5521.061419558604, 5524.447555244444, 5524.558035357242, 5470.835874923759, 5498.560115190695, 5506.732282481109, 5508.366537848199, 5549.112142057252, 5196.298499702643, 5366.0, 5439.48324909133, 5443.482869127427, 5483.616146869681, 5547.2511210986, 5553.361363443256, 5560.944390556043, 5561.082421400423, 5563.8887222256135, 5268.262443258023, 5420.159875219348, 5470.671759694431, 5479.835604931858, 5508.091164957737], "value": 5184.333990231124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8634114153745, 635.1806170040647, 637.760839685118, 646.5797231799331, 661.434473525136, 30492.695073049264, 31176.84411577942, 36913.81543092284, 37477.81261093698, 37507.24985500288, 37310.25379492415, 37784.24431511375, 37929.81035094821, 37935.620643793554, 37959.430608540824, 8474.830503389912, 8690.4351217171, 8690.4351217171, 8693.087225841291, 8696.956515217447, 8490.957545212264, 8611.784705382353, 8616.181462761027, 8617.784555386103, 8629.266512346458, 8819.382643214978, 8895.73312800617, 8904.643814247422, 8906.287497000258, 8918.687845925393, 8802.603882825288, 8821.779455513599, 8868.290536757044, 8888.866667, 8889.955550222272, 8652.053288010211, 8773.605187766565, 8776.210141087333, 8778.341624378134, 8778.47329160246, 39100.0, 39106.60893391058, 39274.80362598169, 39623.20753584941, 39636.80181599074, 3846.2307538492414, 4133.338665813486, 4159.812808423628, 4217.789110544491, 4407.669424793121, 27885.86057069722, 30061.248468788235, 30779.07963495054, 31157.221069473217, 31355.372892542022, 3892.47451594034, 4033.8184781684895, 4052.8176232069627, 4057.82323126293, 4084.36692312692, 249475.0, 250311.0, 251476.0, 251837.7408112966, 252214.0, 44674.0, 52630.473695263325, 52922.73538632282, 52980.0, 52992.20511692328, 50515.0, 51166.48833511692, 51579.22631160536, 51626.74186629118, 51736.0, 16036.0, 16226.594335141479, 16235.918820405823, 16256.187190640421, 16279.51161465158, 10773.461326933622, 12671.239725616493, 12864.935675321563, 12940.352982350845, 12955.352232388343, 14950.102993820406, 15013.624659383384, 15016.774748378783, 15037.323320450607, 15216.847831521765, 6060.2424696912885, 6333.746650133943, 6374.649394283359, 6399.0, 6427.035944608346, 997.5211898288717, 1043.155044414027, 1131.6122980511116, 1158.3455347728507, 1192.1059205595802, 28929.42141157165, 30118.54822177669, 30152.0, 30260.69739302579, 30712.846435768126, 1138.5161306444893, 1194.2416565480983, 1203.5065623094665, 1210.9636710898687, 1226.2274766896799, 15911.204439778196, 16073.598160045858, 16123.516294511184, 16136.515904522883, 16152.273147708382, 371435.0, 376037.0, 378343.0, 378662.0, 378768.0, 53161.0, 53300.73349633227, 53398.0, 53464.46535534673, 53529.57645082615, 1300.7983762516826, 1378.696686728918, 1416.8735854995302, 1467.7284702330103, 1546.36598994414, 29821.0, 31394.21514462157, 31742.682573174898, 32002.147928641185, 32042.19894502656, 43416.0, 43885.12229755323, 44111.55888441203, 44301.11397772091, 44330.77834610806, 241162.0, 241263.0, 242076.0, 245044.0, 249606.0, 22976.540469190855, 23386.883065584563, 23453.76546234516, 25307.114251001127, 25962.572058536964, 41304.58695413007, 41349.0, 42092.78953605212, 42980.35529466998, 43761.78119109511, 37645.49418023248, 37977.4303385455, 38016.429753553166, 38560.42159367556, 38665.80667096759, 37862.24275514529, 38249.0, 38418.42372364473, 38533.4219986706, 38704.41943370795, 38558.228835423695, 38759.418608721455, 39654.603453965094, 39723.808285751475, 39996.0, 32314.0, 33679.4948075784, 34543.827280863436, 35046.0, 35108.824455877555, 25799.355016124748, 26305.0, 26323.0, 26496.8675156623, 26863.83794798025], "value": 18414.316569826962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1211099248674, 394.17420504044054, 402.52301023287424, 406.81489922085444, 409.4492907040032, 13932.791008134885, 15652.530424087296, 17448.91275543622, 17878.463646090622, 18124.63750724985, 13942.302884855768, 17289.30842766291, 17460.47618571442, 18018.5495362616, 18321.54196145097, 5415.187721841716, 5565.41563135871, 5606.243157173791, 5624.29696287964, 5625.915611265814, 4048.9797551012202, 5510.1459273812625, 5674.2339784129235, 5702.344230413514, 5961.523078153759, 6283.465905398047, 6308.463780578656, 6321.968390158066, 6336.239651241857, 6341.207349081365, 6048.485878700316, 6201.131841542187, 6246.843828904268, 6256.405641464076, 6272.1219029335925, 5397.055515284809, 5397.2443857859935, 5398.541124004464, 5403.054465468566, 5450.155225939986, 20078.899605502025, 20432.182712691476, 21263.574728505344, 21276.5744685107, 21426.5714685707, 2480.7147178074574, 2512.836665616729, 2536.8985240590355, 2635.393859412346, 2933.559966005116, 13081.56102828688, 13193.73612527744, 13280.86719132806, 13299.0, 13873.4450621975, 1905.4759941016193, 1958.637652034378, 2061.5670709151095, 2065.452238894734, 2092.7070210170587, 67990.32009679939, 68080.6595967017, 68421.65789171073, 69150.0, 69847.0, 9816.361936474106, 10020.599176033023, 10070.899291007143, 10090.545925433373, 10359.482025898826, 13905.79141312881, 14042.789358159636, 14091.577252682437, 14099.0, 14111.929440352938, 7066.116735408074, 7398.297161769623, 7822.960885195537, 7860.371170306362, 7891.684332626745, 7306.611743768667, 7441.0, 7632.0, 7716.691332346755, 7781.221877812173, 6275.560710750295, 6424.196975378078, 6440.194975628046, 6484.1246431731115, 6486.35136486357, 1873.185164453467, 1925.528245579842, 1929.2958070304237, 1939.660559402099, 1964.762199814108, 942.2320808541155, 1040.8594839696543, 1061.4745700878116, 1098.9505472253768, 1113.4133859250535, 17585.384511542034, 17753.7336939946, 18288.451346459628, 18298.81701182998, 18612.813871861108, 1029.953652085658, 1050.2438244463974, 1054.0144964458257, 1079.7300674831292, 1115.2694984784978, 9284.675036373694, 10475.84286235707, 10520.790109137548, 10533.104686101615, 10556.102731267929, 398122.0, 401895.0, 404748.0, 408928.0, 520164.0, 80636.59681701672, 89278.55360723154, 90378.09621903696, 90626.54686726656, 90647.0, 1025.8102251083574, 1066.594694016269, 1069.7165251208437, 1078.0836289154156, 1090.705509512443, 15661.295241714379, 15803.0, 15829.920850395674, 15849.762253565976, 16583.336666533203, 33752.66247337593, 34066.318673625894, 37410.8129459351, 37853.43219851759, 38090.61909380871, 36197.0, 48510.514894852015, 49118.75440622774, 49504.0, 51083.74458127686, 7783.0, 8079.87880181786, 8129.4715843469985, 8182.877256841271, 8200.958995204986, 12031.879681203425, 12442.31567263773, 12707.745845082862, 12724.936375318064, 13158.671033224246, 10811.35131892089, 11106.888931110585, 11221.71945701364, 11344.773104537699, 11796.4691588877, 10843.512041958289, 11005.1746119043, 11238.269512481662, 11448.255863368855, 11503.079753619857, 11022.724431889266, 11560.30638161713, 11648.359340236368, 11669.12481563903, 11763.647090587296, 7996.280334769898, 8166.265036146538, 8186.09952905168, 8247.752567422987, 8502.149785021697, 11216.943915280697, 11296.401827579539, 11307.095432365555, 11551.942240288745, 11597.478113484745], "value": 9008.297994559045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.3395886953692, 1555.05918919054, 1562.7343351630223, 1756.947291581252, 1827.4060930197688, 7164.140303163621, 8384.16158384162, 8555.95722021389, 8571.828563428735, 8576.39965202436, 8208.630611622477, 8420.157984201576, 8450.873236901436, 8465.0, 8472.661093556266, 2020.5756791073893, 2108.2937216032647, 2225.4436390902274, 2249.741279752829, 2287.4395773035544, 2325.732540757818, 2356.2695564375013, 2358.481134150493, 2358.9056437742556, 2361.8346715729904, 2206.8124209442217, 2233.575620632083, 2243.7644047375034, 2251.6509940959095, 2265.807406370452, 1982.5539253667953, 2201.438633148537, 2244.371575958734, 2257.841951063426, 2294.816414686821, 2242.5402792427512, 2270.5685919675375, 2271.1029143488395, 2274.5678321118935, 2276.8064714499287, 7912.208779122099, 7964.3628509719665, 7965.044194696674, 7965.6017199139815, 7986.081600615946, 4770.8330208442885, 4889.413270407538, 4914.754262286871, 4926.704397736147, 4927.137750893615, 3065.3103051813164, 3143.748500119985, 3244.772865899388, 3248.0, 3252.6259480159847, 1031.886492485826, 1037.5694086953904, 1058.4020028683847, 1064.4411683865956, 1068.2362111090529, 10455.790884182274, 10704.625338113128, 10738.677839664822, 10742.570297188104, 10757.623483178051, 4183.686223533186, 4302.118065796567, 4352.194843953878, 4414.249577571821, 4426.579474949939, 9275.07249275067, 9423.19902808269, 9432.151106400457, 9435.198008169245, 9440.29197810167, 4818.518148185153, 4969.229769385751, 4998.425181104147, 5004.999000199902, 5006.0989021975665, 4202.117555313418, 4673.976630116896, 4674.74288914113, 4784.0, 4832.492588278251, 3905.0432644002403, 3999.8800035998966, 4001.8399264029113, 4004.9599504004586, 4010.8796736097966, 1237.0660151585496, 1268.9682757931125, 1284.062634276983, 1290.3354772292278, 1307.2744626732065, 957.5978089202551, 966.7486453521994, 979.480875136179, 990.3364745620452, 995.4773743784571, 5411.702356370437, 5440.945590544044, 5513.0, 5536.169574563767, 5605.8598535036135, 403.3888658682099, 422.96404805591254, 423.8241129931106, 426.15408414297593, 429.482473619288, 3732.8320225589914, 3760.0975765816006, 3761.4545890845675, 3786.091338078896, 3798.981005094957, 9992.65025724096, 10464.52909619069, 10467.790644187073, 10471.005254500811, 10484.895151048544, 10389.0, 10420.843687344695, 10427.374357538572, 10429.478526073666, 10433.843492347622, 7567.205443428471, 7915.0, 7958.522488650699, 7965.283124518821, 7982.201779821971, 5489.39616642161, 5727.341355744143, 5775.566832487664, 5856.648601083949, 5951.404859514188, 8919.777005574913, 9020.233280171258, 9282.72151835446, 9335.57989890443, 9362.297827662816, 9291.070892910655, 9378.109079637423, 9465.384749991228, 9518.857217141609, 9522.714318570454, 7197.49617526789, 7223.0, 7337.04618399626, 7348.265173482609, 7353.77938661841, 7684.193159718149, 7711.1132219795445, 7773.144954055162, 7783.805404864924, 7798.493097948615, 7090.680919358538, 7236.565806051653, 7320.341169294789, 7353.227911069474, 7390.7413240536325, 7143.673051804443, 7207.963960180376, 7284.635768211462, 7287.744928927462, 7345.853082938418, 6603.20761508622, 6608.4052435281055, 6630.502712296694, 6636.13730215069, 6670.232923213893, 4799.832005879777, 4977.427595826382, 5023.397192336943, 5078.97460512695, 5089.974550127374, 4884.535969082932, 4928.482509336612, 5030.346055012825, 5068.746562671926, 5084.135696931457], "value": 4322.0687485812105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2884292036503, 336.4179968654228, 340.22259137869975, 340.57598290128783, 342.83886573310554, 5126.0, 5160.354955630546, 5162.0, 5201.945231633507, 5219.191025391061, 5107.565856902159, 5127.33344665193, 5136.357955255593, 5139.408967968685, 5163.380394352674, 3850.8459661613574, 3880.0705467372095, 4019.2363450944226, 4047.5952404759582, 4053.412255222991, 4009.8195581198916, 4013.8595149169787, 4018.9598104019024, 4019.9448419201326, 4032.1532478179615, 3842.2315536892593, 3986.5614782373914, 4021.8190181441905, 4023.4970628671417, 4044.130511939932, 3900.941485877714, 4016.1566071124953, 4019.8593049243136, 4021.0244419129926, 4037.5760545142925, 3581.3195492856275, 3592.940082675617, 3594.19130695594, 3600.4959305697225, 3608.2061946371755, 4967.726775027372, 5010.824621138243, 5017.172166592508, 5038.521340472649, 5054.292399064134, 4607.861764147081, 4674.696144750615, 4678.508756580578, 4680.134175177603, 4706.670533062653, 5364.202991997686, 5402.459754024605, 5411.485908838654, 5420.91868621971, 5423.430539793344, 4019.738716983416, 4030.879073627796, 4031.8992025199314, 4037.586844604394, 4047.413125096874, 5365.946340536584, 5636.746346414421, 5636.859078523029, 5665.405132461074, 5683.476244728254, 3940.4286378474962, 3943.684505239574, 3955.4066889966734, 3964.861229856941, 3967.345388010946, 3988.720789544762, 3993.2612466693754, 3997.620226078518, 3999.7000224983244, 4018.296798060386, 4442.600165985077, 4589.609883159902, 4592.931106033412, 4609.723416595015, 4611.262198048364, 5320.893582128413, 5325.786968521215, 5364.946350536523, 5371.5702743781185, 5409.513143817076, 1446.7251222267735, 1453.8328092269312, 1464.5386703188462, 1477.5493474490384, 1481.4518628107453, 921.8202450522218, 975.4196253229459, 975.531744762518, 995.1541189988452, 1007.1338648762058, 5514.5864060194845, 5532.972335138298, 5545.085060964896, 5550.250716153349, 5562.666240025612, 5866.8533286667325, 5867.9413205867395, 5877.353491115974, 5880.8235752927485, 5895.64626122434, 5385.784568617211, 5514.503694667499, 5528.226048353234, 5551.750171242304, 5558.304717061254, 3095.0250671038552, 3103.8758449662214, 3128.530720391959, 3131.0, 3131.1076343242066, 5877.882442351129, 6102.328743838174, 6105.534671678765, 6106.297775755756, 6108.267007959073, 5917.822465326047, 5987.0, 6019.939800601938, 6030.819075427744, 6032.969835150796, 6003.249593800775, 6012.7294271757, 6060.2424696912885, 6060.606060606046, 6067.180930574316, 5697.069022374549, 5881.735321910439, 5908.911366329423, 5911.586188966731, 5913.2608423947, 5796.710164491843, 5825.650460972186, 5829.125631155191, 5842.853928651818, 5868.3251426086545, 5492.176173573996, 5764.538836893123, 6002.169338351845, 6046.969765151146, 6095.116208149705, 3889.8833035008997, 3913.6673382762783, 3916.7845768483007, 3930.3318435866545, 3942.9605703942593, 5589.385167631639, 5622.116590942081, 5626.409227031267, 5633.873225355027, 5646.689432081275, 5250.369955605352, 5438.782448702166, 5446.774475743085, 5449.3188351456065, 5497.45025497463, 5441.619086664054, 5442.156465747816, 5442.673439593637, 5467.535259502987, 5474.206240095244, 5086.109930762028, 5198.428172901054, 5364.865878353073, 5378.946210538001, 5390.137577987503, 5405.8107966221, 5417.539509141767, 5428.6199966002005, 5464.562834973272, 5465.972670136783, 5338.8932221356135, 5365.973170134281, 5369.3556773187465, 5378.677279363251, 5384.219288203267], "value": 4219.513304710023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6209364271045, 754.5585832288111, 812.1513018895254, 834.4659417972498, 865.1348651348651, 13861.1683299002, 15338.616534586641, 15671.84328156718, 15715.842841571566, 15753.527394178165, 14231.359588818503, 14540.491082812103, 14553.854461455383, 14717.558473245794, 14773.704525909476, 690.5787469643514, 804.7585724282721, 820.9794755131124, 830.0578843013193, 831.2601784411878, 817.6606708216083, 823.9629216685233, 824.5094168969454, 826.6445428465757, 827.9254867061964, 871.0114020586616, 872.9912700873006, 874.7594411536815, 875.0374587953232, 875.4965894610592, 713.5896859305919, 853.7012045783988, 855.6235256487125, 860.862262038074, 888.7955770172896, 615.5352708704944, 618.1253526260336, 618.6133666458463, 625.6183727925961, 626.1703243202729, 14475.131492110508, 14500.564983050524, 14511.0, 14518.0, 14527.0, 13094.345282735825, 13463.528776492776, 13471.595852124452, 13503.392347344394, 13596.0, 12230.341422051579, 12274.0, 12542.435590398454, 12549.02349166104, 12746.29895355755, 4448.7108337957925, 4449.065696203768, 4472.351509031172, 4495.797689103998, 4573.908521829545, 55452.72273638606, 55503.72248138733, 55533.44466555323, 55693.443065569234, 56342.718286408715, 10851.0, 11065.778684426266, 11148.0, 11155.776884462266, 11546.364949927667, 20674.0, 20814.37556873296, 20903.68644470334, 20991.895040524698, 21026.789732102483, 7943.205679432011, 8060.879086813702, 8065.6370463329295, 8070.556119413372, 8367.456115352483, 4557.430321209848, 4600.4479462464715, 4616.60758835496, 4700.88247793801, 4716.716996980193, 3524.4713293006253, 3592.2995015971633, 3614.403623402162, 3615.6384361563632, 3618.1135621772833, 569.5842035314244, 622.0606883605788, 634.9428551430393, 636.7707625254905, 644.6390021587926, 682.6518475577392, 732.8204589875514, 742.1539445032668, 762.6720510180564, 764.5947647746704, 9683.41899486033, 9798.608055677692, 9830.557624906896, 9846.113849753556, 9953.751156221007, 663.7477758451854, 694.2918223412091, 761.8019314978035, 762.6949220311809, 783.1620166421874, 4283.443152390231, 4436.423264975532, 4466.865994020184, 4497.190505709003, 4612.07758448305, 65199.48005199537, 67331.0, 68024.3197568018, 68094.65952670205, 68503.31496684969, 60042.0, 60240.397596024355, 60661.69669151626, 61111.69444152751, 62057.0, 54408.45591544034, 54889.451105489235, 55014.449855501734, 55602.44397555973, 56395.71802140963, 8641.265492432962, 8697.6955806549, 8759.386842921189, 8813.383063185516, 8833.070858318079, 35484.11289717778, 35969.46045809367, 36532.0, 36566.0, 36965.260694785415, 45222.0, 47643.0, 47902.76048619874, 48144.03711925812, 48548.514514854396, 11590.710232243924, 12151.453184606891, 12483.12618116723, 12505.312207828656, 12525.56160534377, 12400.937995309965, 12681.80977285323, 13286.734265314446, 13381.933090334485, 13597.86402135966, 12274.324912129918, 12380.566680166152, 12452.128351015343, 12904.806427903777, 13113.344332783132, 13100.344982750634, 13211.14127581704, 13465.259410732504, 13474.326283685581, 14284.857151428352, 12945.611631651065, 13201.867981320063, 13213.603591892259, 13324.133931294435, 14315.498957536436, 10853.674389768319, 10926.672199834018, 11193.720156995814, 11254.60608878718, 11938.0, 10383.84424233622, 11017.394043327695, 11037.503312350804, 11140.554377824796, 11307.265027773497], "value": 6973.930906102947, "unit": "score"}], "name": "dromaeo_css", "value": 6915.568783298934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 109.0, 113.0, 112.0, 101.0, 112.0, 111.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 155.0, 182.0, 127.0, 154.0, 161.0, 135.0, 199.0, 128.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 116.0, 114.0, 76.0, 72.0, 73.0, 117.0, 111.0, 75.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 92.0, 92.0, 93.0, 153.0, 93.0, 93.0, 146.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 116.0, 116.0, 117.0, 118.0, 117.0, 116.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 148.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 56.0, 57.0, 58.0, 57.0, 76.0, 61.0, 53.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 60.0, 61.0, 59.0, 61.0, 60.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 75.0, 76.0, 76.0, 78.0, 77.0, 84.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 132.0, 128.0, 126.0, 122.0, 134.0, 125.0, 157.0, 136.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 201.0, 196.0, 199.0, 204.0, 198.0, 198.0, 199.0, 195.0, 206.0], "value": 199.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 71.0, 68.0, 71.0, 69.0, 67.0, 70.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1577.3, "alertThreshold": 2.0}]} 07:32:14 INFO - Return code: 0 07:32:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:32:14 ERROR - # TBPL SUCCESS # 07:32:14 INFO - Running post-action listener: _resource_record_post_action 07:32:14 INFO - Running post-run listener: _resource_record_post_run 07:32:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 537903104; Read time: 0; Write time: 701200 07:32:15 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244723712; Read time: 0; Write time: 433120 07:32:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292933632; Read time: 0; Write time: 268000 07:32:15 INFO - Running post-run listener: _upload_blobber_files 07:32:15 INFO - Blob upload gear active. 07:32:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:32:15 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'] 07:32:15 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 07:32:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:32:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:16 INFO - (blobuploader) - INFO - Done attempting. 07:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:17 INFO - (blobuploader) - INFO - Done attempting. 07:32:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:17 INFO - Return code: 0 07:32:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e30c4c56e403a019733fd398803f0c20c15010f977b459aa8ef2adef97eac3159569d8ae3975900b83626b487d57b3ebd1666941878c3955f19f68e01fe850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3342cba22f510fbda8c8878922b36a99e72fc327eeb4acac1cede39085efddea7148716c9a8670294f31b2b950d9f6aad1afe380171d04f452c5aa73f5dccfec"} 07:32:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:17 INFO - Contents: 07:32:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e30c4c56e403a019733fd398803f0c20c15010f977b459aa8ef2adef97eac3159569d8ae3975900b83626b487d57b3ebd1666941878c3955f19f68e01fe850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3342cba22f510fbda8c8878922b36a99e72fc327eeb4acac1cede39085efddea7148716c9a8670294f31b2b950d9f6aad1afe380171d04f452c5aa73f5dccfec"} 07:32:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:17 INFO - Copying logs to upload dir... 07:32:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.723269 ========= master_lag: 98.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-04-27 07:33:54.917334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:33:54.920401) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 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/48e30c4c56e403a019733fd398803f0c20c15010f977b459aa8ef2adef97eac3159569d8ae3975900b83626b487d57b3ebd1666941878c3955f19f68e01fe850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3342cba22f510fbda8c8878922b36a99e72fc327eeb4acac1cede39085efddea7148716c9a8670294f31b2b950d9f6aad1afe380171d04f452c5aa73f5dccfec"} build_url:https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/JuIJe0jpRlmtwsiRTn7PRQ/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/48e30c4c56e403a019733fd398803f0c20c15010f977b459aa8ef2adef97eac3159569d8ae3975900b83626b487d57b3ebd1666941878c3955f19f68e01fe850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3342cba22f510fbda8c8878922b36a99e72fc327eeb4acac1cede39085efddea7148716c9a8670294f31b2b950d9f6aad1afe380171d04f452c5aa73f5dccfec"}' ========= master_lag: 0.52 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:33:55.450915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:33:55.451300) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461766274.687124-78751822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:33:55.588089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:33:55.588358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:33:55.588764) ========= ========= Total master_lag: 98.84 =========