builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1467132194.0 results: success (0) buildid: 20160628070023 builduid: fbc89a7bc5f2471e854f2ee2b4571072 revision: 85ccaed0061c96468658c35137c86467166624d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:13.996564) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:13.997084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:13.997456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.014148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.014451) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 09:43:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.8M=0s 2016-06-28 09:43:14 (48.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.153422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.153787) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.207408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.207855) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85ccaed0061c96468658c35137c86467166624d5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85ccaed0061c96468658c35137c86467166624d5 --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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 09:43:14,474 truncating revision to first 12 chars 2016-06-28 09:43:14,474 Setting DEBUG logging. 2016-06-28 09:43:14,475 attempt 1/10 2016-06-28 09:43:14,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/85ccaed0061c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 09:43:14,788 unpacking tar archive at: mozilla-beta-85ccaed0061c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.889776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.890152) ========= script_repo_revision: 85ccaed0061c96468658c35137c86467166624d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.890623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.890948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:43:14.901271) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-28 09:43:14.901602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:15 INFO - MultiFileLogger online at 20160628 09:43:15 in /builds/slave/test 09:43:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:43:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:15 INFO - {'append_to_log': False, 09:43:15 INFO - 'base_work_dir': '/builds/slave/test', 09:43:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:43:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:15 INFO - 'branch': 'Mozilla-Beta', 09:43:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:15 INFO - 'config_files': ('talos/linux_config.py',), 09:43:15 INFO - 'default_actions': ('clobber', 09:43:15 INFO - 'read-buildbot-config', 09:43:15 INFO - 'download-and-extract', 09:43:15 INFO - 'populate-webroot', 09:43:15 INFO - 'create-virtualenv', 09:43:15 INFO - 'install', 09:43:15 INFO - 'run-tests'), 09:43:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:15 INFO - 'download_minidump_stackwalk': True, 09:43:15 INFO - 'download_symbols': 'ondemand', 09:43:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:15 INFO - 'installer_path': 'installer.exe', 09:43:15 INFO - 'log_level': 'info', 09:43:15 INFO - 'log_name': 'talos', 09:43:15 INFO - 'log_to_console': True, 09:43:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:15 INFO - 'opt_config_files': (), 09:43:15 INFO - 'pip_index': False, 09:43:15 INFO - 'sps_profile': False, 09:43:15 INFO - 'sps_profile_interval': 0, 09:43:15 INFO - 'suite': 'dromaeojs', 09:43:15 INFO - 'system_bits': '32', 09:43:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:15 INFO - 'title': 'talos-linux64-ix-062', 09:43:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:15 INFO - 'use_talos_json': True, 09:43:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:15 INFO - 'work_dir': 'build'} 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running clobber step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: clobber 09:43:15 INFO - rmtree: /builds/slave/test/build 09:43:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:15 INFO - Running post-action listener: _resource_record_post_action 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running read-buildbot-config step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: read_buildbot_config 09:43:15 INFO - Using buildbot properties: 09:43:15 INFO - { 09:43:15 INFO - "project": "", 09:43:15 INFO - "product": "firefox", 09:43:15 INFO - "script_repo_revision": "production", 09:43:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:43:15 INFO - "repository": "", 09:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:43:15 INFO - "buildid": "20160628070023", 09:43:15 INFO - "pgo_build": "True", 09:43:15 INFO - "basedir": "/builds/slave/test", 09:43:15 INFO - "buildnumber": 288, 09:43:15 INFO - "slavename": "talos-linux64-ix-062", 09:43:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:43:15 INFO - "platform": "ubuntu64_hw", 09:43:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:43:15 INFO - "branch": "mozilla-beta", 09:43:15 INFO - "repo_path": "releases/mozilla-beta", 09:43:15 INFO - "revision": "85ccaed0061c96468658c35137c86467166624d5", 09:43:15 INFO - "stage_platform": "linux64-pgo", 09:43:15 INFO - "builduid": "fbc89a7bc5f2471e854f2ee2b4571072", 09:43:15 INFO - "slavebuilddir": "test" 09:43:15 INFO - } 09:43:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:43:15 INFO - Running post-action listener: _resource_record_post_action 09:43:15 INFO - ##### 09:43:15 INFO - ##### Running download-and-extract step. 09:43:15 INFO - ##### 09:43:15 INFO - Running pre-action listener: _resource_record_pre_action 09:43:15 INFO - Running main action method: download_and_extract 09:43:15 INFO - mkdir: /builds/slave/test/build/tests 09:43:15 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')]} 09:43:15 INFO - https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:43:16 INFO - Downloaded 1327 bytes. 09:43:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:43:16 INFO - Using the following test package requirements: 09:43:16 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:43:16 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:16 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:43:16 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'jsshell-linux-x86_64.zip'], 09:43:16 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:16 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:43:16 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:43:16 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:43:16 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:16 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:43:16 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43: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')]} 09:43:16 INFO - https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:43:17 INFO - Downloaded 24236241 bytes. 09:43:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:43:18 INFO - Return code: 0 09:43:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:18 INFO - https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:43:20 INFO - Downloaded 24236241 bytes. 09:43:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:43:21 INFO - Return code: 0 09:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:21 INFO - https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:43:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:43:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:43:22 INFO - Downloaded 10840145 bytes. 09:43:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:43:22 INFO - Return code: 0 09:43:22 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')]} 09:43:22 INFO - https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:43:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:43:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:43:24 INFO - Downloaded 56019831 bytes. 09:43:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:43:24 INFO - mkdir: /builds/slave/test/properties 09:43:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:24 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:24 INFO - Contents: 09:43:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:43:24 INFO - Running post-action listener: _resource_record_post_action 09:43:24 INFO - Running post-action listener: set_extra_try_arguments 09:43:24 INFO - ##### 09:43:24 INFO - ##### Running populate-webroot step. 09:43:24 INFO - ##### 09:43:24 INFO - Running pre-action listener: _resource_record_pre_action 09:43:24 INFO - Running main action method: populate_webroot 09:43:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:24 INFO - '--tppagecycles', 09:43:24 INFO - '7'], 09:43:24 INFO - 'tests': ['tsvgm']}}, 09:43:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:43:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:43:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:43:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['damp', 'tps']}, 09:43:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'tests': ['damp', 'tps']}, 09:43:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['dromaeo_dom']}, 09:43:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['a11yr', 09:43:24 INFO - 'ts_paint', 09:43:24 INFO - 'tpaint', 09:43:24 INFO - 'sessionrestore', 09:43:24 INFO - 'sessionrestore_no_auto_restore', 09:43:24 INFO - 'tabpaint']}, 09:43:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['tsvgx', 09:43:24 INFO - 'tsvgr_opacity', 09:43:24 INFO - 'tart', 09:43:24 INFO - 'tscrollx', 09:43:24 INFO - 'cart']}, 09:43:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:43:24 INFO - 'tsvgr_opacity', 09:43:24 INFO - 'tart', 09:43:24 INFO - 'tscrollx', 09:43:24 INFO - 'cart']}, 09:43:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'talos_options': ['--disable-e10s'], 09:43:24 INFO - 'tests': ['tp5o']}, 09:43:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'tests': ['tp5o']}, 09:43:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'talos_options': ['--disable-e10s', 09:43:24 INFO - '--xperf_path', 09:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:24 INFO - 'tests': ['tp5n']}, 09:43:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:24 INFO - 'talos_options': ['--xperf_path', 09:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:24 INFO - 'tests': ['tp5n']}}, 09:43:24 INFO - 'talos.zip': {'path': '', 09:43:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:24 INFO - Running post-action listener: _resource_record_post_action 09:43:24 INFO - ##### 09:43:24 INFO - ##### Running create-virtualenv step. 09:43:24 INFO - ##### 09:43:24 INFO - Running pre-action listener: _resource_record_pre_action 09:43:24 INFO - Running main action method: create_virtualenv 09:43:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:24 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 09:43:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:24 INFO - Using real prefix '/usr' 09:43:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:27 INFO - Installing pip.................done. 09:43:27 INFO - Return code: 0 09:43:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:27 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 09:43:27 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 09:43:27 INFO - Using env: {'DISPLAY': ':0', 09:43:27 INFO - 'HOME': '/home/cltbld', 09:43:27 INFO - 'LANG': 'en_US.UTF-8', 09:43:27 INFO - 'LANGUAGE': 'en_US:en', 09:43:27 INFO - 'LOGNAME': 'cltbld', 09:43:27 INFO - 'MAIL': '/var/mail/cltbld', 09:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:27 INFO - 'MOZ_NO_REMOTE': '1', 09:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:27 INFO - 'NO_EM_RESTART': '1', 09:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:27 INFO - 'PWD': '/builds/slave/test', 09:43:27 INFO - 'SHELL': '/bin/bash', 09:43:27 INFO - 'SHLVL': '1', 09:43:27 INFO - 'TERM': 'linux', 09:43:27 INFO - 'TMOUT': '86400', 09:43:27 INFO - 'USER': 'cltbld', 09:43:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:27 INFO - '_': '/tools/buildbot/bin/python'} 09:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:27 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 09:43:27 INFO - Cleaning up... 09:43:27 INFO - Return code: 0 09:43:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:27 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 09:43:27 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 09:43:27 INFO - Using env: {'DISPLAY': ':0', 09:43:27 INFO - 'HOME': '/home/cltbld', 09:43:27 INFO - 'LANG': 'en_US.UTF-8', 09:43:27 INFO - 'LANGUAGE': 'en_US:en', 09:43:27 INFO - 'LOGNAME': 'cltbld', 09:43:27 INFO - 'MAIL': '/var/mail/cltbld', 09:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:27 INFO - 'MOZ_NO_REMOTE': '1', 09:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:27 INFO - 'NO_EM_RESTART': '1', 09:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:27 INFO - 'PWD': '/builds/slave/test', 09:43:27 INFO - 'SHELL': '/bin/bash', 09:43:27 INFO - 'SHLVL': '1', 09:43:27 INFO - 'TERM': 'linux', 09:43:27 INFO - 'TMOUT': '86400', 09:43:27 INFO - 'USER': 'cltbld', 09:43:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:27 INFO - '_': '/tools/buildbot/bin/python'} 09:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:27 INFO - Downloading/unpacking psutil>=0.7.1 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:29 INFO - Installing collected packages: psutil 09:43:29 INFO - Running setup.py install for psutil 09:43:29 INFO - building 'psutil._psutil_linux' extension 09:43:29 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 09:43:30 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 09:43:30 INFO - building 'psutil._psutil_posix' extension 09:43:30 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 09:43:30 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 09:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:30 INFO - Successfully installed psutil 09:43:30 INFO - Cleaning up... 09:43:30 INFO - Return code: 0 09:43:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:30 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:30 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 09:43:30 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 09:43:30 INFO - Using env: {'DISPLAY': ':0', 09:43:30 INFO - 'HOME': '/home/cltbld', 09:43:30 INFO - 'LANG': 'en_US.UTF-8', 09:43:30 INFO - 'LANGUAGE': 'en_US:en', 09:43:30 INFO - 'LOGNAME': 'cltbld', 09:43:30 INFO - 'MAIL': '/var/mail/cltbld', 09:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:30 INFO - 'MOZ_NO_REMOTE': '1', 09:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:30 INFO - 'NO_EM_RESTART': '1', 09:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:30 INFO - 'PWD': '/builds/slave/test', 09:43:30 INFO - 'SHELL': '/bin/bash', 09:43:30 INFO - 'SHLVL': '1', 09:43:30 INFO - 'TERM': 'linux', 09:43:30 INFO - 'TMOUT': '86400', 09:43:30 INFO - 'USER': 'cltbld', 09:43:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:30 INFO - '_': '/tools/buildbot/bin/python'} 09:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:30 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 09:43:30 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 09:43:30 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 09:43:30 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 09:43:30 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 09:43:30 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 09:43:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:43:32 INFO - Installing collected packages: mozsystemmonitor 09:43:32 INFO - Running setup.py install for mozsystemmonitor 09:43:32 INFO - Successfully installed mozsystemmonitor 09:43:32 INFO - Cleaning up... 09:43:32 INFO - Return code: 0 09:43:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:32 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:32 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 09:43:32 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 09:43:32 INFO - Using env: {'DISPLAY': ':0', 09:43:32 INFO - 'HOME': '/home/cltbld', 09:43:32 INFO - 'LANG': 'en_US.UTF-8', 09:43:32 INFO - 'LANGUAGE': 'en_US:en', 09:43:32 INFO - 'LOGNAME': 'cltbld', 09:43:32 INFO - 'MAIL': '/var/mail/cltbld', 09:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:32 INFO - 'MOZ_NO_REMOTE': '1', 09:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:32 INFO - 'NO_EM_RESTART': '1', 09:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:32 INFO - 'PWD': '/builds/slave/test', 09:43:32 INFO - 'SHELL': '/bin/bash', 09:43:32 INFO - 'SHLVL': '1', 09:43:32 INFO - 'TERM': 'linux', 09:43:32 INFO - 'TMOUT': '86400', 09:43:32 INFO - 'USER': 'cltbld', 09:43:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:32 INFO - '_': '/tools/buildbot/bin/python'} 09:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:43:32 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 09:43:32 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 09:43:32 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 09:43:32 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 09:43:32 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 09:43:32 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 09:43:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43:34 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 09:43:34 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 09:43:34 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 09:43:34 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 09:43:34 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 09:43:34 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 09:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:43:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:35 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 09:43:35 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 09:43:35 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 09:43:35 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 09:43:35 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 09:43:35 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 09:43:35 INFO - Downloading docopt-0.6.1.tar.gz 09:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:35 INFO - Running setup.py install for blobuploader 09:43:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:43:35 INFO - Running setup.py install for requests 09:43:36 INFO - Running setup.py install for docopt 09:43:36 INFO - Successfully installed blobuploader requests docopt 09:43:36 INFO - Cleaning up... 09:43:36 INFO - Return code: 0 09:43:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:36 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:36 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 09:43:36 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 09:43:36 INFO - Using env: {'DISPLAY': ':0', 09:43:36 INFO - 'HOME': '/home/cltbld', 09:43:36 INFO - 'LANG': 'en_US.UTF-8', 09:43:36 INFO - 'LANGUAGE': 'en_US:en', 09:43:36 INFO - 'LOGNAME': 'cltbld', 09:43:36 INFO - 'MAIL': '/var/mail/cltbld', 09:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:36 INFO - 'MOZ_NO_REMOTE': '1', 09:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:36 INFO - 'NO_EM_RESTART': '1', 09:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:36 INFO - 'PWD': '/builds/slave/test', 09:43:36 INFO - 'SHELL': '/bin/bash', 09:43:36 INFO - 'SHLVL': '1', 09:43:36 INFO - 'TERM': 'linux', 09:43:36 INFO - 'TMOUT': '86400', 09:43:36 INFO - 'USER': 'cltbld', 09:43:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:36 INFO - '_': '/tools/buildbot/bin/python'} 09:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:36 INFO - Running setup.py (path:/tmp/pip-jHmJhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:36 INFO - Running setup.py (path:/tmp/pip-qw8lhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:36 INFO - Running setup.py (path:/tmp/pip-_6R3dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:36 INFO - Running setup.py (path:/tmp/pip-3muRIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:36 INFO - Running setup.py (path:/tmp/pip-C4tgEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:36 INFO - Running setup.py (path:/tmp/pip-eNexE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:36 INFO - Running setup.py (path:/tmp/pip-8XuYbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:36 INFO - Running setup.py (path:/tmp/pip-_QXsIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:37 INFO - Running setup.py (path:/tmp/pip-pzqf3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:37 INFO - Running setup.py (path:/tmp/pip-J8fhYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:37 INFO - Running setup.py (path:/tmp/pip-1HTbHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:37 INFO - Running setup.py (path:/tmp/pip-iNbr6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:37 INFO - Running setup.py (path:/tmp/pip-o1MOuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:37 INFO - Running setup.py (path:/tmp/pip-IYfo1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:37 INFO - Running setup.py (path:/tmp/pip-GrWyhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:37 INFO - Running setup.py (path:/tmp/pip-cu5Fhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:37 INFO - Running setup.py (path:/tmp/pip-aSHjMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:37 INFO - Running setup.py install for manifestparser 09:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:43:37 INFO - Running setup.py install for mozcrash 09:43:37 INFO - Running setup.py install for mozdebug 09:43:37 INFO - Running setup.py install for mozdevice 09:43:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozfile 09:43:38 INFO - Running setup.py install for mozhttpd 09:43:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozinfo 09:43:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozInstall 09:43:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozleak 09:43:38 INFO - Running setup.py install for mozlog 09:43:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for moznetwork 09:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:43:38 INFO - Running setup.py install for mozprocess 09:43:38 INFO - Running setup.py install for mozprofile 09:43:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Running setup.py install for mozrunner 09:43:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Running setup.py install for mozscreenshot 09:43:39 INFO - Running setup.py install for moztest 09:43:39 INFO - Running setup.py install for mozversion 09:43:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:43:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:39 INFO - Cleaning up... 09:43:39 INFO - Return code: 0 09:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:39 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:39 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 09:43:39 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 09:43:39 INFO - Using env: {'DISPLAY': ':0', 09:43:39 INFO - 'HOME': '/home/cltbld', 09:43:39 INFO - 'LANG': 'en_US.UTF-8', 09:43:39 INFO - 'LANGUAGE': 'en_US:en', 09:43:39 INFO - 'LOGNAME': 'cltbld', 09:43:39 INFO - 'MAIL': '/var/mail/cltbld', 09:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:39 INFO - 'MOZ_NO_REMOTE': '1', 09:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:39 INFO - 'NO_EM_RESTART': '1', 09:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:39 INFO - 'PWD': '/builds/slave/test', 09:43:39 INFO - 'SHELL': '/bin/bash', 09:43:39 INFO - 'SHLVL': '1', 09:43:39 INFO - 'TERM': 'linux', 09:43:39 INFO - 'TMOUT': '86400', 09:43:39 INFO - 'USER': 'cltbld', 09:43:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:39 INFO - '_': '/tools/buildbot/bin/python'} 09:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:39 INFO - Running setup.py (path:/tmp/pip-_72mln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:39 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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:39 INFO - Running setup.py (path:/tmp/pip-57zBnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:39 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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:39 INFO - Running setup.py (path:/tmp/pip-e0PPGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:39 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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:39 INFO - Running setup.py (path:/tmp/pip-Xyiv3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:39 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)) 09:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:39 INFO - Running setup.py (path:/tmp/pip-3Ss0gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:40 INFO - Running setup.py (path:/tmp/pip-NSP69Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:40 INFO - Running setup.py (path:/tmp/pip-UPHp56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:40 INFO - Running setup.py (path:/tmp/pip-C2pWfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:40 INFO - Running setup.py (path:/tmp/pip-mRgcKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:40 INFO - Running setup.py (path:/tmp/pip-kHD99n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:40 INFO - Running setup.py (path:/tmp/pip-IOKOGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:40 INFO - Running setup.py (path:/tmp/pip-qp5vR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:40 INFO - Running setup.py (path:/tmp/pip-Zmyt4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:40 INFO - Running setup.py (path:/tmp/pip-puPlux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:40 INFO - Running setup.py (path:/tmp/pip-oG4D1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:40 INFO - Running setup.py (path:/tmp/pip-9leCrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:40 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)) 09:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:40 INFO - Running setup.py (path:/tmp/pip-euqZO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:40 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)) 09:43:40 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)) 09:43:40 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)) 09:43:40 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)) 09:43:40 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)) 09:43:40 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)) 09:43:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:42 INFO - Downloading blessings-1.6.tar.gz 09:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:42 INFO - Installing collected packages: blessings 09:43:42 INFO - Running setup.py install for blessings 09:43:42 INFO - Successfully installed blessings 09:43:42 INFO - Cleaning up... 09:43:43 INFO - Return code: 0 09:43:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:43 INFO - Reading from file tmpfile_stdout 09:43:43 INFO - Current package versions: 09:43:43 INFO - argparse == 1.2.1 09:43:43 INFO - blessings == 1.6 09:43:43 INFO - blobuploader == 1.2.4 09:43:43 INFO - docopt == 0.6.1 09:43:43 INFO - manifestparser == 1.1 09:43:43 INFO - mozInstall == 1.12 09:43:43 INFO - mozcrash == 0.17 09:43:43 INFO - mozdebug == 0.1 09:43:43 INFO - mozdevice == 0.48 09:43:43 INFO - mozfile == 1.2 09:43:43 INFO - mozhttpd == 0.7 09:43:43 INFO - mozinfo == 0.9 09:43:43 INFO - mozleak == 0.1 09:43:43 INFO - mozlog == 3.1 09:43:43 INFO - moznetwork == 0.27 09:43:43 INFO - mozprocess == 0.22 09:43:43 INFO - mozprofile == 0.28 09:43:43 INFO - mozrunner == 6.11 09:43:43 INFO - mozscreenshot == 0.1 09:43:43 INFO - mozsystemmonitor == 0.0 09:43:43 INFO - moztest == 0.7 09:43:43 INFO - mozversion == 1.4 09:43:43 INFO - psutil == 3.1.1 09:43:43 INFO - requests == 1.2.3 09:43:43 INFO - wsgiref == 0.1.2 09:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 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 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:43 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 09:43:43 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 09:43:43 INFO - Using env: {'DISPLAY': ':0', 09:43:43 INFO - 'HOME': '/home/cltbld', 09:43:43 INFO - 'LANG': 'en_US.UTF-8', 09:43:43 INFO - 'LANGUAGE': 'en_US:en', 09:43:43 INFO - 'LOGNAME': 'cltbld', 09:43:43 INFO - 'MAIL': '/var/mail/cltbld', 09:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:43 INFO - 'MOZ_NO_REMOTE': '1', 09:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:43 INFO - 'NO_EM_RESTART': '1', 09:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:43 INFO - 'PWD': '/builds/slave/test', 09:43:43 INFO - 'SHELL': '/bin/bash', 09:43:43 INFO - 'SHLVL': '1', 09:43:43 INFO - 'TERM': 'linux', 09:43:43 INFO - 'TMOUT': '86400', 09:43:43 INFO - 'USER': 'cltbld', 09:43:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:43 INFO - '_': '/tools/buildbot/bin/python'} 09:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 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)) 09:43:43 INFO - Cleaning up... 09:43:43 INFO - Return code: 0 09:43:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:43:43 INFO - Using env: {'DISPLAY': ':0', 09:43:43 INFO - 'HOME': '/home/cltbld', 09:43:43 INFO - 'LANG': 'en_US.UTF-8', 09:43:43 INFO - 'LANGUAGE': 'en_US:en', 09:43:43 INFO - 'LOGNAME': 'cltbld', 09:43:43 INFO - 'MAIL': '/var/mail/cltbld', 09:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:43 INFO - 'MOZ_NO_REMOTE': '1', 09:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:43 INFO - 'NO_EM_RESTART': '1', 09:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:43 INFO - 'PWD': '/builds/slave/test', 09:43:43 INFO - 'SHELL': '/bin/bash', 09:43:43 INFO - 'SHLVL': '1', 09:43:43 INFO - 'TERM': 'linux', 09:43:43 INFO - 'TMOUT': '86400', 09:43:43 INFO - 'USER': 'cltbld', 09:43:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:43 INFO - '_': '/tools/buildbot/bin/python'} 09:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:43 INFO - Downloading/unpacking jsonschema 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:43:45 INFO - Downloading/unpacking functools32 (from jsonschema) 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:43:45 INFO - warning: no files found matching '*.txt' 09:43:45 INFO - no previously-included directories found matching 'build' 09:43:45 INFO - no previously-included directories found matching 'dist' 09:43:45 INFO - no previously-included directories found matching '.git*' 09:43:45 INFO - Installing collected packages: jsonschema, functools32 09:43:45 INFO - Running setup.py install for functools32 09:43:45 INFO - warning: no files found matching '*.txt' 09:43:45 INFO - no previously-included directories found matching 'build' 09:43:45 INFO - no previously-included directories found matching 'dist' 09:43:45 INFO - no previously-included directories found matching '.git*' 09:43:46 INFO - Successfully installed jsonschema functools32 09:43:46 INFO - Cleaning up... 09:43:46 INFO - Return code: 0 09:43:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24f57aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', '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 09:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:43:46 INFO - Using env: {'DISPLAY': ':0', 09:43:46 INFO - 'HOME': '/home/cltbld', 09:43:46 INFO - 'LANG': 'en_US.UTF-8', 09:43:46 INFO - 'LANGUAGE': 'en_US:en', 09:43:46 INFO - 'LOGNAME': 'cltbld', 09:43:46 INFO - 'MAIL': '/var/mail/cltbld', 09:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:46 INFO - 'MOZ_NO_REMOTE': '1', 09:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:46 INFO - 'NO_EM_RESTART': '1', 09:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:46 INFO - 'PWD': '/builds/slave/test', 09:43:46 INFO - 'SHELL': '/bin/bash', 09:43:46 INFO - 'SHLVL': '1', 09:43:46 INFO - 'TERM': 'linux', 09:43:46 INFO - 'TMOUT': '86400', 09:43:46 INFO - 'USER': 'cltbld', 09:43:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:46 INFO - '_': '/tools/buildbot/bin/python'} 09:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:46 INFO - Downloading/unpacking flake8 09:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:43:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:43:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:48 INFO - no previously-included directories found matching 'docs/_build' 09:43:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:43:48 INFO - Running setup.py install for pep8 09:43:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:49 INFO - no previously-included directories found matching 'docs/_build' 09:43:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:43:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:43:49 INFO - Cleaning up... 09:43:49 INFO - Return code: 0 09:43:49 INFO - Running post-action listener: _resource_record_post_action 09:43:49 INFO - Running post-action listener: _start_resource_monitoring 09:43:49 INFO - Starting resource monitoring. 09:43:49 INFO - ##### 09:43:49 INFO - ##### Running install step. 09:43:49 INFO - ##### 09:43:49 INFO - Running pre-action listener: _resource_record_pre_action 09:43:49 INFO - Running main action method: install 09:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:49 INFO - Reading from file tmpfile_stdout 09:43:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:49 INFO - Reading from file tmpfile_stdout 09:43:49 INFO - Output received: 09:43:49 INFO - Usage: mozinstall [options] installer 09:43:49 INFO - Options: 09:43:49 INFO - -h, --help show this help message and exit 09:43:49 INFO - -d DEST, --destination=DEST 09:43:49 INFO - Directory to install application into. [default: 09:43:49 INFO - "/builds/slave/test"] 09:43:49 INFO - --app=APP Application being installed. [default: firefox] 09:43:49 INFO - mkdir: /builds/slave/test/build/application 09:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:44:02 INFO - Reading from file tmpfile_stdout 09:44:02 INFO - Output received: 09:44:02 INFO - /builds/slave/test/build/application/firefox/firefox 09:44:02 INFO - Running post-action listener: _resource_record_post_action 09:44:02 INFO - ##### 09:44:02 INFO - ##### Running run-tests step. 09:44:02 INFO - ##### 09:44:02 INFO - Running pre-action listener: _resource_record_pre_action 09:44:02 INFO - Running main action method: run_tests 09:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:02 INFO - Python 2.7.3 09:44:02 INFO - Return code: 0 09:44:02 INFO - grabbing minidump binary from tooltool 09:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:02 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 0x213e410>, '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 0x213f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:02 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 09:44:02 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 09:44:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:02 INFO - Return code: 0 09:44:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:44:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:44:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:44:03 INFO - Return code: 0 09:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 09:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 09:44:03 INFO - Using env: {'DISPLAY': ':0', 09:44:03 INFO - 'HOME': '/home/cltbld', 09:44:03 INFO - 'LANG': 'en_US.UTF-8', 09:44:03 INFO - 'LANGUAGE': 'en_US:en', 09:44:03 INFO - 'LOGNAME': 'cltbld', 09:44:03 INFO - 'MAIL': '/var/mail/cltbld', 09:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:03 INFO - 'MOZ_NO_REMOTE': '1', 09:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:03 INFO - 'NO_EM_RESTART': '1', 09:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:03 INFO - 'PWD': '/builds/slave/test', 09:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:03 INFO - 'SHELL': '/bin/bash', 09:44:03 INFO - 'SHLVL': '1', 09:44:03 INFO - 'TERM': 'linux', 09:44:03 INFO - 'TMOUT': '86400', 09:44:03 INFO - 'USER': 'cltbld', 09:44:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817', 09:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:03 INFO - '_': '/tools/buildbot/bin/python'} 09:44:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 09:44:03 INFO - mozversion application_buildid: 20160628070023 09:44:03 INFO - mozversion application_changeset: 85ccaed0061c96468658c35137c86467166624d5 09:44:03 INFO - mozversion application_display_name: Firefox 09:44:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:03 INFO - mozversion application_name: Firefox 09:44:03 INFO - mozversion application_remotingname: firefox 09:44:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:44:03 INFO - mozversion application_vendor: Mozilla 09:44:03 INFO - mozversion application_version: 48.0 09:44:03 INFO - mozversion platform_buildid: 20160628070023 09:44:03 INFO - mozversion platform_changeset: 85ccaed0061c96468658c35137c86467166624d5 09:44:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:44:03 INFO - mozversion platform_version: 48.0 09:44:03 INFO - using testdate: 1467132243 09:44:03 INFO - actual date: 1467132243 09:44:03 INFO - starting webserver on 'localhost:52154' 09:44:03 INFO - SUITE-START | Running 2 tests 09:44:03 INFO - TEST-START | dromaeo_css 09:44:03 INFO - operating with platform_type : linux_ 09:44:03 INFO - Initialising browser for dromaeo_css test... 09:44:03 INFO - TEST-INFO | started process 13485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpItBjKN/profile http://localhost:52154/getInfo.html) 09:44:07 INFO - PROCESS | 13485 | __metrics Screen width/height:1600/1200 09:44:07 INFO - PROCESS | 13485 | colorDepth:24 09:44:07 INFO - PROCESS | 13485 | Browser inner width/height: 1024/697 09:44:07 INFO - PROCESS | 13485 | __metrics 09:44:08 ERROR - PROCESS | 13485 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:44:09 INFO - TEST-INFO | 13485: exit 0 09:44:09 INFO - Browser initialized. 09:44:09 INFO - Running cycle 1/1 for dromaeo_css test... 09:44:09 INFO - TEST-INFO | started process 13577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpItBjKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:21 INFO - PROCESS | 13577 | RSS: Main: 139300864 09:44:21 INFO - PROCESS | 13577 | 09:45:12 INFO - PROCESS | 13577 | 1467132312525 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] 09:47:19 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52154/tests/dromaeo/cssquery-ext.html) 09:47:20 INFO - PROCESS | 13577 | RSS: Main: 242249728 09:47:20 INFO - PROCESS | 13577 | 09:50:22 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-ext.html (next: http://localhost:52154/tests/dromaeo/cssquery-jquery.html) 09:50:23 INFO - PROCESS | 13577 | RSS: Main: 218001408 09:50:23 INFO - PROCESS | 13577 | 09:53:24 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52154/tests/dromaeo/cssquery-mootools.html) 09:53:25 INFO - PROCESS | 13577 | RSS: Main: 216113152 09:53:25 INFO - PROCESS | 13577 | 09:56:27 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52154/tests/dromaeo/cssquery-prototype.html) 09:56:27 INFO - PROCESS | 13577 | RSS: Main: 222572544 09:56:27 INFO - PROCESS | 13577 | 09:59:30 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52154/tests/dromaeo/cssquery-yui.html) 09:59:30 INFO - PROCESS | 13577 | RSS: Main: 181182464 09:59:30 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:52154/tests/dromaeo/cssquery-yui.html (next: http://localhost:52154/tests/dromaeo/cssquery-dojo.html) 10:02:33 INFO - PROCESS | 13577 | RSS: Main: 250888192 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | __start_tp_report 10:02:33 INFO - PROCESS | 13577 | _x_x_mozilla_page_load 10:02:33 INFO - PROCESS | 13577 | _x_x_mozilla_page_load_details 10:02:33 INFO - PROCESS | 13577 | |i|pagename|runs| 10:02:33 INFO - PROCESS | 13577 | |0;dojo.html;3303.2897926945707;3347.7991320520755;3371.1235078879486;3378.1385746634605;3387.6442973487783;5513.889722205554;5517.889642207154;5532.751026203815;5540.445955404458;5545.833624991256;5482.506574408302;5515.696636684981;5541.861453463665;5566.165075238716;5570.442955704428;4903;4956.083124621948;5064;5098.082345177866;5131.076406246874;4895.8776030599165;4949.628777841658;4990.575801056914;5019.121653710605;5031.698098114125;4991.450940396553;5029.195328747401;5035.093683137034;5051.292819005343;5073.239014147871;5069.771860266297;5073.644844860843;5084.51697088776;5089.160288552384;5120.052790233782;4893.584045356149;4938.654294199408;4993.775280112403;5010.423801262865;5053.772580233862;5418.485243901862;5423.538999185074;5427.023135835548;5437.918431223535;5438.129899216146;5841.3282472515775;5873.706314684291;5877.206577112078;5881.764729410818;5885.234919460486;5793.681347525884;5808.4772370486435;5862.794802181946;5888.087346461305;5911.852203694899;5519.751611177467;5524.8342549723175;5528.419515950848;5531.25328080708;5532.917006244869;5998.580099393001;5999.670018148957;6001.63990160583;6006.399360064046;6035.8792824143275;5690.829275121753;5760.6543607382855;5777.19119323295;5828.154917537018;5869.765209391577;5866;5869.090291004901;5876.294844618673;5878.059510478303;5878.177055212273;5763.94236057634;5849.824505264849;5855.912161317584;5856.590038697335;5863.120531920161;5783.334916484574;5862.296524417097;5875.529957603381;5908.527317814564;5917.644941303535;4469.486009108994;4474.418325617714;4477.843275485342;4479.619232365286;4481.148581769454;3981.6615587675374;3996.84012639497;4030.858919937788;4043.332850079763;4064.8577299794956;5720.856978575485;5727.513161381329;5747.683877386784;5756.884862302731;5788.507976821933;5916.615419997686;5935.703214839241;5950.137230101611;5952.136940143655;5954.07711804671;5481.725913704299;5621.494065534122;5727.885442291131;5745.798897038583;5758.049921762862;5020.397552293675;5023.321851550067;5031.22016087507;5046.646734728533;5047.646664733434;6149.446549810538;6165.352637973038;6167.352427994996;6173.56785025044;6175.84560385994;5724.284464441945;5880.088586269135;5893.2928048633585;5923.822285331447;5998.070299103646;6198.6280823150755;6214.130021797043;6239;6242.438180563771;6255.655938923403;5829.621074630305;5849.356570777296;5854.209681692917;5857.26784151981;5885.852853678693;5727.828165155052;5805.94194058054;5892.94107058924;5897.262842144732;5924.763009479745;5768.913466297925;5778.16216648592;5782.161586570008;5787.652740835563;5789.044807606698;5716.5998380113;5760.366359700346;5763.884722305615;5783.132530120347;5786.826395208151;5516.14499752539;5649.293838270216;5702.857428564319;5715.828255207589;5740.311162660508;5701.828945131652;5728.427157284238;5729.169270455844;5729.427057294237;5734.856628584319;5635.098384258499;5636.182753500638;5640.041192997118;5642.125470552071;5645.1532270159805 10:02:33 INFO - PROCESS | 13577 | |1;ext.html;666.5367569539167;673.5588189735722;688.0401839433989;748.4498893313414;758.9354904833085;33155.17112072199;33914.1521461963;33928.32143357131;33930.32139357214;33961.32077358451;33686.831565842134;40160.99999999993;40889;41030.58969410305;41071.38392924101;8894.733158005254;9037.051109633492;9043.095690430937;9044.819103617923;9049.321300902426;8346.499210047386;8605.182507661762;8651.221390074892;8697.173768491983;8755.25580325673;10843.240973131884;11163.051140653055;11163.274387164809;11168.609098681547;11184.496697648625;10563.049325560698;10669.786604267949;10670.199735019827;10670.51982660782;10677.359358438518;10394.324368915995;10522.368657880552;10527;10528;10535.473226338729;40643.390349144785;41011.17977640431;41046.79476602628;41121.58878411208;41164;3597.6582224688614;3615.5842078161086;3665.6151104134215;3709.55485341758;4159.729617574848;33520.32959340824;34191.658083419345;34246.65753342485;34487.13782155441;34692.30615387678;3917.98041009796;3943;3946.269940061069;4071.8982025449304;4116.217918595487;329668;329695;330981;331226;332601.99999999756;64136;64152;64552.35447645463;64569.67715161394;64596;68229.65885170542;70816.291837082;71659.6417017922;71724;71785.2821471789;17926.91036544809;18282.177302021442;18346.541336466697;18351.54121146982;18353.90823045903;12998.415071321813;13000;13004;13008.739825203444;13019.088663793444;18987.71518427225;20801.58396832085;21057.57884842325;21302.893485532473;21464.141434342764;7467.2421458580075;7548.773536793905;7559.962200189074;7803.492772969739;7838.216178382117;1137.732632831284;1155.174050553858;1171.4611278811672;1229.3361584744139;1284.441268048402;33044.83477582597;33335.33329333448;33568.66431335704;33798.49302260468;33996.32007359839;1208.1542919956066;1214.9817752733538;1258.2010423381219;1279.7248591552861;1292.011611117496;17133.97196168234;17853.116363527377;17888.55278618045;18109.7283540747;18506.907465462587;463911;467206;469386;470576;472179;64418.35581644217;64590;65023.34976650267;65441.69116617641;65489.345106548324;1522.2312732070234;1529.0825504697093;1541.6454215530491;1543.7221300165854;1552.3247387386298;29156.27109322284;31027.970676143417;32901;33107;33350.16624584308;52382.47617523776;53103.4689653114;53377.46622533725;53405;53456.198157028455;361914;370809;370878;370899;371061;27374;29704.702952970194;29993.70006299909;30023.84988075133;30273.24316892095;47087;47352.7632361836;47602.285965711235;48450;48526.5147348522;39837.40243896402;39933.201335973696;40118.398224027245;40414.79792601018;41233;37888.62111378961;38491;38585.2282954345;38717.6128238714;39251.214975700896;39824.362522091826;40493.39259911163;41010.589894100674;41533.1693366125;41566.79216603898;33036.50445243371;35207.64792352044;35286.47070293896;35486.46770298499;36003.45994810132;28042.71957280401;28222.71777282283;28240.576391353734;28444.85777571099;28553.714462855107 10:02:33 INFO - PROCESS | 13577 | |2;jquery.html;418.5835094081389;422.54787377506074;429.8796337025634;433.32185130271125;436.8842256801946;18488.26046958122;19083.809161908375;19251.518712032208;19290.710639340403;20071;13183.736325273489;13194.472221111144;13214.735705285888;18442.44672659819;19909.104090315934;5165.5092766187245;5342.572594192475;5385.084535628933;5399.892002159954;5401.378841433227;5760.913586296209;5787.623804452697;5815.418458154193;5831.708414579254;5843.655959129403;5478.096114141162;5783.855403614923;5785.913211301834;5787.421257874221;5797.072468405056;5350.30446042014;5362.383325917492;5369.9463005369835;5381.7578208980685;5386.434424385442;5241.50205730455;5245.134552798783;5254.264402983586;5255.842324730264;5262.657927234717;21520.139194432202;22670.886645566665;22989;23413.297601071994;23495.530089398286;2531.6076008218756;2631.25009372328;2637.7626013658864;2838.963778220955;2884.9614138909974;10186.796264074677;10236.948815255875;10940.23418360715;11634.418279086096;14191.361388737532;2019.121682068305;2028.1177687705895;2033.8677985931015;2048.6619707748355;2068.720722702446;79005;79196.60401698013;81542.59228703819;82842.58578707128;83164;11103.666889993314;11352;11528.944829620157;11547.364894930692;11760.705982350339;16149.273282702306;16166.595835104217;16185.595360115856;16312.184390780414;16312.918435407748;8683.956580217058;8986.337527557424;8989.325800564984;9007.153533525743;9060.592273347715;8726.389152759246;8804.735857924272;8815.471071735716;8846.424982376126;8859.06979767115;4831.589314908272;4954.529319714621;5002.449730529639;5043.394792624908;5071.239314102914;1878.727584500267;1918.3957053528095;2042.7548694156797;2075.9792402076087;2112.271266413085;1035.8705161854768;1061.0662616897082;1087.380193289833;1099.2415233488866;1101.7741363020723;18085.499445781385;18689.158987845578;18795;18925.526861828563;18949;1069.0912724184536;1082.7022568793486;1099.9395033273247;1115.0967716149783;1126.695792136135;10174.389536627827;10640;10654.893451065545;10676.62631807883;10741.83887241692;496207;503535;507148;509608;521158;66530;76037.61981190059;78798.21201788023;91106;93138;1061.932757578644;1061.9734506637242;1076.6662334676275;1089.4716062709579;1093.8742044664966;13275.468981240641;16137.515874523782;16298;16611.83388166103;16873.240704168587;33989;35262;35479.467807982386;36171.45742813807;36284.45573316349;51065.74467127641;52210.47789522056;52887;53681.19478207908;54180.74915504925;8866.42368246062;8894.68868589622;8921.286297096347;8962.417442866194;9059.411138275991;9733.13337372257;12968.221906685629;13098.803517947048;13257.204567725967;13515.932420337835;11431.256968297033;11611.477483513094;11703.76592468163;11779.52881884715;11818.881811181778;11360.1479889007;11422.200445968703;11533.077353811843;11546.48040838181;11608.30350178992;10945.631077649117;11479.885201147881;11698;11835.526578936746;12007.879921200676;8622.61198246068;8652.524111173945;8995.100489950952;9022.819543608959;9110.407823491452;8735.344849136467;10938.671839844817;11388.544458221579;11495.367754773568;11496.597619083292 10:02:33 INFO - PROCESS | 13577 | |3;mootools.html;1335.7194989052298;1553.9300731467083;1568.4510421352525;1792.336835370913;1976.1305025788652;8275.255227029566;8579.099194584573;8580.528070956096;8583.184597463247;8585.527795971218;8326.084130745614;8483.109273526283;8497.490150590953;8504.872426913602;8515;2369.336585755991;2395.9281221563383;2398.736139024706;2401.2556107606697;2401.2916189723987;2410;2422.685050943375;2437.5734246506877;2470.629405589167;2483.242611003652;2365.5387199496104;2381.5951288281035;2405.434722840131;2409.5301416223756;2426.0538390027905;2362.65741467488;2402.3633737059695;2415.9758402416014;2427.8786060696893;2432.598621227495;2365.586022446082;2410.433548116191;2414.2515820095828;2432.221689059502;2435.634654801794;7434.814129646802;7605;8598;8661.783455413664;8681.131886811332;5091.974540127313;5185.403678576937;5185.922211166798;5197.636165468419;5202.505761952609;3270.5421241026274;3275.7215636670912;3311.304626028537;3350.949735753966;3371.865125394981;1056.873175218971;2062.61841559312;2068.079704531484;2098.664213725812;2110.5673336965883;12151.878481215163;12238.204516706475;12239.755204895851;12274.38628068593;12298.569550065704;4350.825966961286;4406.25093734066;4463.397441345377;4466.731996080245;4594.701344412602;9709.514524273758;9799.608015679292;9802.411855288705;9814.803703925882;9815.607375705034;5300.628955973045;5315.202719592015;5350.277712508761;5355.196720491879;5385.784568617211;4917.680350777188;4960.032793605213;4962.925556116661;4964.106460837012;4971.130052240844;3653.2328211075974;3814.9427758583643;3842.615738426135;3871.1483473635753;3871.9419208711893;1132.4337831084458;1156.942152892352;1158.472894832849;1164.0745607242093;1175.4710380328886;817.5748610722391;885.57049830832;941.750436134425;971.0968799016982;1010.5604062232952;5706.430731548858;5810;5812.854678632983;5877.882442351214;5921.467067963904;946.2477330522114;1044.6552637629563;1045.4877110216091;1045.9058684718411;1062.6758838554315;4046.716729828943;4049.0687141957515;4062.857799976987;4074.4295798588223;4149.398337241083;10187.337823041627;10663.466826658636;10694.197935154894;10847.51186196623;10872.130229581773;10393.84409233862;10549;10595.311304765166;10648.840267395995;10651.041406273473;8429;8494.787630309169;8572.742817715478;8581.01318348398;8581.141885811368;5830.416958304136;5887.116932459994;5912.46787789101;5939.376365481735;6036.245469316335;9587.952060239653;9630.951845240728;9653.855192171983;9655.855162172433;9809.950950245204;9516.571754271214;9748.756281093029;9832.360896541702;10080.596776129167;10082.495875206358;7242.311980361857;7309.780706578811;7351.8162045949275;7424.034875466371;7431.479796414199;8027.919720802717;8227.670893164446;8242.17578242195;8252.711155109542;8255.25702686761;7388.778336649909;7502.962485187539;7526.134494533198;7692.653830577749;7826;7593.734219302298;7634.847303054019;7648.617569121633;7664.73173438927;7674.117476490275;6614.239362473185;6713.160854893138;6725.125733654593;6734;6746.595204287759;4108.842857499836;4954.851354459372;5013.448520662797;5038.269450929522;5089.643724939367;5056.494350565061;5123.92314115296;5138.3833939927445;5143;5254.65844720092 10:02:33 INFO - PROCESS | 13577 | |4;prototype.html;350.4935368392672;351.80650642146827;353.4980327934333;363.1683444911153;365.7531166462638;5929.614575052618;5930.673812940287;5958.523318134549;5962.463378295953;5998.130271110686;6068.635881847081;6133.1413602095745;6141;6145.508359331254;6150.354212807658;4543.295789152687;4588.967482316469;4665.300204969265;4719.339292499053;4756.690815097017;4687.88280292992;4706.694064885772;4715.198416269242;4716.009637976029;4716.457607375144;4682.344471773954;4686.367340409035;4689.132510485554;4689.437267527885;4694.483606803249;4675.50907154749;4683.086798074377;4692.343071969944;4693.694909830884;4694.037722266927;4090.5909409059154;4109.075458021921;4112.136451345221;4139.130782535671;4145.233131870614;5755.338136114358;5910.822675319747;5913.8817223655715;5914.645121292736;5921.437463440966;5391.73041347931;5397.730113494349;5400.243965844785;5401.891962160774;5403.7027963462;6323.051542268697;6349.873002539924;6357.65032923189;6366.267879193906;6368.808935731936;4421.602055814992;4525.230710779142;4539.273716205391;4539.432570928634;4540.046590216059;6676.799696009079;6718.563293385914;6730.057791909087;6745.730170793162;6747.156605424322;4583.747893865802;4584.564466375689;4586.151561961048;4593.63250939924;4598.724076555417;4679.766011699469;4680.017196388729;4680.485146633868;4681.9297710534365;4688.906221875543;5140.897182056413;5388.272583201296;5393.298871146804;5403.756830942617;5405.324334458192;6337.144485494491;6357.11000459936;6359.141515895388;6365.904511432333;6475.190601174853;1625.7398816189352;1634.4606279927832;1643.8520533152073;1643.9424620138477;1644.0957473389587;1059.6026490066224;1070.930389524694;1092.153580974735;1102.5424448853637;1103.5530610102921;6361.968190159019;6367.076773867763;6367.172267605274;6375.0437434384285;6397.872042559123;6599.637019963948;6602;6609.438197753148;6615.86768264632;6637.634930078795;6358.968205158944;6370.617762934239;6379.075034120026;6387.361263873669;6388.4569811566535;3551.7691350062164;3584.2831433713363;3590.8922732318074;3594.101474631342;3595.5865075516126;6876.17485901695;7040.014397984286;7044.788656340318;7052.647367631598;7055.717771289091;6767.898481522781;6770.898436523456;6779.2881747416795;6789.72841086351;6792.45660347171;6994.405475534535;7007.754728584577;7013.754518591825;7026.92973070273;7036.155661320572;6607.768728094494;6612.338766123542;6631.834204144935;6636.668166591555;6676.632785196861;6523.3150519194805;6567.770128045496;6651.501137414616;6661.233958094881;6665.966670166618;7089.64551772399;7108.644567771487;7113.751018714527;7125.287471252833;7136.4290856730295;4599.747013914133;4639.188142075191;4644.117617652635;4645.419322584677;4646.117237724821;6437.935620643733;6556.770513032021;6667.666616669244;6670.599764014175;6675.198976122702;6438.67806609677;6477.935220647733;6483.286838447672;6507.056476810931;6513.478921686159;6470.870582588416;6480.449161821298;6487.578307410004;6497.480201583957;6505.967470162619;6364.109024736448;6387.552871298964;6392.968035159981;6394.5523813334485;6395.968020159869;6370.713317900613;6539.6076235424125;6543.378379053982;6551.836204094936;6571.704273307617;6365.745370185141;6389.2652344980925;6390.169277993831;6396.264429590657;6406.647634380154 10:02:33 INFO - PROCESS | 13577 | |5;yui.html;841.7643059943215;842.6755699055866;846.4667259626434;854.7563944275882;856.3235044314991;14200.573982780521;14632.634184145401;14651.926740366283;14667.046641968278;14679.486217982372;12534.93732531336;13396.464141434355;13446.529371472001;13449.865501345008;13454.05821592489;921.8847644044495;951.1297163095759;952.2953014769056;953.7186529973675;955.3646824861494;938.132227689388;941.4398432932428;944.3200895355333;946.8390373636498;950.0072424316605;810.84999275134;983.2871168402922;986.1568359053014;989.8267803134459;992.2409356842022;957.4686049242667;977.1889331854544;986.344081186014;986.7187851462371;990.5592011554861;714.9142102947627;715.0347031507423;715.5849607227796;716.2372073741449;716.4590733995852;13794.241316727575;13871.722565548733;13897.652558686013;13970.441182352693;13995.16029038261;14639.41442342305;14991;15000.774988375075;15032;15100.395984160621;11387.08903287735;11459.197856150073;11487.368194749286;11601.767964640745;11625.59310424131;3827.445020472044;3878.553966293884;3916.236333914888;3921.117748506563;3947.1513624570566;50913.23630145551;51085.744571277275;51107.744461277456;51741;52093.218601721004;10619.575216991389;11293.830592541119;11405.942970285096;11446.853537773579;11753.471093800628;18239.817601824077;18369.26522939094;18406.81593184051;18449.262029518668;18470.261189552537;8782.736517904474;8803;8819.823603527893;8895.510746908982;9151.17639412456;4594.241950078266;4614.584687378152;4713.599344055725;4715.198416269174;4762.880927976828;3572.4462708280257;3622.9818850906104;3625.2568223514118;3629.4011488104165;3632.2917031179195;615.6183166436748;657.7040331850686;696.5472442912046;713;717.6519388096768;717.4762423430925;723.1105739939799;732.4140687450125;739.8261408568982;747.9401647868158;8836.337274704423;8864.379493435526;9143.13140251675;9210.35527513081;9326.95336523313;531.662394379564;597.070991147733;647.1166857239833;666.3736088077192;679.4869873245767;4215.578442155821;4306.590873866978;4313.762743049099;4327.718698284664;4410.25025745624;64998.025029624594;65976.67011664911;66213.668931656;66288.66855665787;66620.6668966652;56832.43167568272;56983.71508142433;57581;57719.42280577224;57989;48311.75844120827;48896.26655600169;52109;52543.949121017366;54793.452065478836;9556.426614403159;9838.557264923238;10027.29808913369;10051;10420.843687344544;37630.247395052495;38341.42487862628;38480.23039539249;38787.2242555153;40070.1985960285;45528.317075243234;45529.317060244786;48109.75945120252;49094.509054908995;49449;11703.76592468163;11712.765744685228;11833.704157396134;12033.819492707442;12298.75402491963;13270.867291326964;13659.726805464034;13781.793273100711;13855.099418537762;13919.443222270997;12813.167144135601;12921.547745829226;13157.671058223621;13243.867561324263;13701.383437745126;12815.871841281842;12900;13363.665908352368;13449.529266475627;13736.65658358509;13161.868381316064;13302.733945320846;13508.189508629514;13740.65648358799;13908.37412316428;10856.620018299322;11059.668209953714;11120.443977800916;11152.721181970515;11437.142214334124;10887.032299328277;11066.723331916766;11143.777124457303;11263.887361126612;11264.774704506028 10:02:33 INFO - PROCESS | 13577 | __end_tp_report 10:02:33 INFO - PROCESS | 13577 | __start_cc_report 10:02:33 INFO - PROCESS | 13577 | _x_x_mozilla_cycle_collect,838 10:02:33 INFO - PROCESS | 13577 | __end_cc_report 10:02:33 INFO - PROCESS | 13577 | __startTimestamp1467133353604__endTimestamp 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | ------- Summary: start ------- 10:02:33 INFO - PROCESS | 13577 | Number of tests: 6 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#0] dojo.html Cycles:165 Average:5485.97 Median:5727.83 stddev:608.47 (10.6%) stddev-sans-first:585.75 10:02:33 INFO - PROCESS | 13577 | Values: 3303.3 3347.8 3371.1 3378.1 3387.6 5513.9 5517.9 5532.8 5540.4 5545.8 5482.5 5515.7 5541.9 5566.2 5570.4 4903.0 4956.1 5064.0 5098.1 5131.1 4895.9 4949.6 4990.6 5019.1 5031.7 4991.5 5029.2 5035.1 5051.3 5073.2 5069.8 5073.6 5084.5 5089.2 5120.1 4893.6 4938.7 4993.8 5010.4 5053.8 5418.5 5423.5 5427.0 5437.9 5438.1 5841.3 5873.7 5877.2 5881.8 5885.2 5793.7 5808.5 5862.8 5888.1 5911.9 5519.8 5524.8 5528.4 5531.3 5532.9 5998.6 5999.7 6001.6 6006.4 6035.9 5690.8 5760.7 5777.2 5828.2 5869.8 5866.0 5869.1 5876.3 5878.1 5878.2 5763.9 5849.8 5855.9 5856.6 5863.1 5783.3 5862.3 5875.5 5908.5 5917.6 4469.5 4474.4 4477.8 4479.6 4481.1 3981.7 3996.8 4030.9 4043.3 4064.9 5720.9 5727.5 5747.7 5756.9 5788.5 5916.6 5935.7 5950.1 5952.1 5954.1 5481.7 5621.5 5727.9 5745.8 5758.0 5020.4 5023.3 5031.2 5046.6 5047.6 6149.4 6165.4 6167.4 6173.6 6175.8 5724.3 5880.1 5893.3 5923.8 5998.1 6198.6 6214.1 6239.0 6242.4 6255.7 5829.6 5849.4 5854.2 5857.3 5885.9 5727.8 5805.9 5892.9 5897.3 5924.8 5768.9 5778.2 5782.2 5787.7 5789.0 5716.6 5760.4 5763.9 5783.1 5786.8 5516.1 5649.3 5702.9 5715.8 5740.3 5701.8 5728.4 5729.2 5729.4 5734.9 5635.1 5636.2 5640.0 5642.1 5645.2 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#1] ext.html Cycles:180 Average:56555.94 Median:19800.56 stddev:103828.51 (524.4%) stddev-sans-first:104034.97 10:02:33 INFO - PROCESS | 13577 | Values: 666.5 673.6 688.0 748.4 758.9 33155.2 33914.2 33928.3 33930.3 33961.3 33686.8 40161.0 40889.0 41030.6 41071.4 8894.7 9037.1 9043.1 9044.8 9049.3 8346.5 8605.2 8651.2 8697.2 8755.3 10843.2 11163.1 11163.3 11168.6 11184.5 10563.0 10669.8 10670.2 10670.5 10677.4 10394.3 10522.4 10527.0 10528.0 10535.5 40643.4 41011.2 41046.8 41121.6 41164.0 3597.7 3615.6 3665.6 3709.6 4159.7 33520.3 34191.7 34246.7 34487.1 34692.3 3918.0 3943.0 3946.3 4071.9 4116.2 329668.0 329695.0 330981.0 331226.0 332602.0 64136.0 64152.0 64552.4 64569.7 64596.0 68229.7 70816.3 71659.6 71724.0 71785.3 17926.9 18282.2 18346.5 18351.5 18353.9 12998.4 13000.0 13004.0 13008.7 13019.1 18987.7 20801.6 21057.6 21302.9 21464.1 7467.2 7548.8 7560.0 7803.5 7838.2 1137.7 1155.2 1171.5 1229.3 1284.4 33044.8 33335.3 33568.7 33798.5 33996.3 1208.2 1215.0 1258.2 1279.7 1292.0 17134.0 17853.1 17888.6 18109.7 18506.9 463911.0 467206.0 469386.0 470576.0 472179.0 64418.4 64590.0 65023.3 65441.7 65489.3 1522.2 1529.1 1541.6 1543.7 1552.3 29156.3 31028.0 32901.0 33107.0 33350.2 52382.5 53103.5 53377.5 53405.0 53456.2 361914.0 370809.0 370878.0 370899.0 371061.0 27374.0 29704.7 29993.7 30023.8 30273.2 47087.0 47352.8 47602.3 48450.0 48526.5 39837.4 39933.2 40118.4 40414.8 41233.0 37888.6 38491.0 38585.2 38717.6 39251.2 39824.4 40493.4 41010.6 41533.2 41566.8 33036.5 35207.6 35286.5 35486.5 36003.5 28042.7 28222.7 28240.6 28444.9 28553.7 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#2] jquery.html Cycles:180 Average:28791.20 Median:23201.15 stddev:83348.63 (359.2%) stddev-sans-first:83555.22 10:02:33 INFO - PROCESS | 13577 | Values: 418.6 422.5 429.9 433.3 436.9 18488.3 19083.8 19251.5 19290.7 20071.0 13183.7 13194.5 13214.7 18442.4 19909.1 5165.5 5342.6 5385.1 5399.9 5401.4 5760.9 5787.6 5815.4 5831.7 5843.7 5478.1 5783.9 5785.9 5787.4 5797.1 5350.3 5362.4 5369.9 5381.8 5386.4 5241.5 5245.1 5254.3 5255.8 5262.7 21520.1 22670.9 22989.0 23413.3 23495.5 2531.6 2631.3 2637.8 2839.0 2885.0 10186.8 10236.9 10940.2 11634.4 14191.4 2019.1 2028.1 2033.9 2048.7 2068.7 79005.0 79196.6 81542.6 82842.6 83164.0 11103.7 11352.0 11528.9 11547.4 11760.7 16149.3 16166.6 16185.6 16312.2 16312.9 8684.0 8986.3 8989.3 9007.2 9060.6 8726.4 8804.7 8815.5 8846.4 8859.1 4831.6 4954.5 5002.4 5043.4 5071.2 1878.7 1918.4 2042.8 2076.0 2112.3 1035.9 1061.1 1087.4 1099.2 1101.8 18085.5 18689.2 18795.0 18925.5 18949.0 1069.1 1082.7 1099.9 1115.1 1126.7 10174.4 10640.0 10654.9 10676.6 10741.8 496207.0 503535.0 507148.0 509608.0 521158.0 66530.0 76037.6 78798.2 91106.0 93138.0 1061.9 1062.0 1076.7 1089.5 1093.9 13275.5 16137.5 16298.0 16611.8 16873.2 33989.0 35262.0 35479.5 36171.5 36284.5 51065.7 52210.5 52887.0 53681.2 54180.7 8866.4 8894.7 8921.3 8962.4 9059.4 9733.1 12968.2 13098.8 13257.2 13515.9 11431.3 11611.5 11703.8 11779.5 11818.9 11360.1 11422.2 11533.1 11546.5 11608.3 10945.6 11479.9 11698.0 11835.5 12007.9 8622.6 8652.5 8995.1 9022.8 9110.4 8735.3 10938.7 11388.5 11495.4 11496.6 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#3] mootools.html Cycles:180 Average:5709.05 Median:5047.38 stddev:3147.50 (62.4%) stddev-sans-first:3139.17 10:02:33 INFO - PROCESS | 13577 | Values: 1335.7 1553.9 1568.5 1792.3 1976.1 8275.3 8579.1 8580.5 8583.2 8585.5 8326.1 8483.1 8497.5 8504.9 8515.0 2369.3 2395.9 2398.7 2401.3 2401.3 2410.0 2422.7 2437.6 2470.6 2483.2 2365.5 2381.6 2405.4 2409.5 2426.1 2362.7 2402.4 2416.0 2427.9 2432.6 2365.6 2410.4 2414.3 2432.2 2435.6 7434.8 7605.0 8598.0 8661.8 8681.1 5092.0 5185.4 5185.9 5197.6 5202.5 3270.5 3275.7 3311.3 3350.9 3371.9 1056.9 2062.6 2068.1 2098.7 2110.6 12151.9 12238.2 12239.8 12274.4 12298.6 4350.8 4406.3 4463.4 4466.7 4594.7 9709.5 9799.6 9802.4 9814.8 9815.6 5300.6 5315.2 5350.3 5355.2 5385.8 4917.7 4960.0 4962.9 4964.1 4971.1 3653.2 3814.9 3842.6 3871.1 3871.9 1132.4 1156.9 1158.5 1164.1 1175.5 817.6 885.6 941.8 971.1 1010.6 5706.4 5810.0 5812.9 5877.9 5921.5 946.2 1044.7 1045.5 1045.9 1062.7 4046.7 4049.1 4062.9 4074.4 4149.4 10187.3 10663.5 10694.2 10847.5 10872.1 10393.8 10549.0 10595.3 10648.8 10651.0 8429.0 8494.8 8572.7 8581.0 8581.1 5830.4 5887.1 5912.5 5939.4 6036.2 9588.0 9631.0 9653.9 9655.9 9810.0 9516.6 9748.8 9832.4 10080.6 10082.5 7242.3 7309.8 7351.8 7424.0 7431.5 8027.9 8227.7 8242.2 8252.7 8255.3 7388.8 7503.0 7526.1 7692.7 7826.0 7593.7 7634.8 7648.6 7664.7 7674.1 6614.2 6713.2 6725.1 6734.0 6746.6 4108.8 4954.9 5013.4 5038.3 5089.6 5056.5 5123.9 5138.4 5143.0 5254.7 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#4] prototype.html Cycles:180 Average:5430.88 Median:6330.10 stddev:1636.45 (25.9%) stddev-sans-first:1595.99 10:02:33 INFO - PROCESS | 13577 | Values: 350.5 351.8 353.5 363.2 365.8 5929.6 5930.7 5958.5 5962.5 5998.1 6068.6 6133.1 6141.0 6145.5 6150.4 4543.3 4589.0 4665.3 4719.3 4756.7 4687.9 4706.7 4715.2 4716.0 4716.5 4682.3 4686.4 4689.1 4689.4 4694.5 4675.5 4683.1 4692.3 4693.7 4694.0 4090.6 4109.1 4112.1 4139.1 4145.2 5755.3 5910.8 5913.9 5914.6 5921.4 5391.7 5397.7 5400.2 5401.9 5403.7 6323.1 6349.9 6357.7 6366.3 6368.8 4421.6 4525.2 4539.3 4539.4 4540.0 6676.8 6718.6 6730.1 6745.7 6747.2 4583.7 4584.6 4586.2 4593.6 4598.7 4679.8 4680.0 4680.5 4681.9 4688.9 5140.9 5388.3 5393.3 5403.8 5405.3 6337.1 6357.1 6359.1 6365.9 6475.2 1625.7 1634.5 1643.9 1643.9 1644.1 1059.6 1070.9 1092.2 1102.5 1103.6 6362.0 6367.1 6367.2 6375.0 6397.9 6599.6 6602.0 6609.4 6615.9 6637.6 6359.0 6370.6 6379.1 6387.4 6388.5 3551.8 3584.3 3590.9 3594.1 3595.6 6876.2 7040.0 7044.8 7052.6 7055.7 6767.9 6770.9 6779.3 6789.7 6792.5 6994.4 7007.8 7013.8 7026.9 7036.2 6607.8 6612.3 6631.8 6636.7 6676.6 6523.3 6567.8 6651.5 6661.2 6666.0 7089.6 7108.6 7113.8 7125.3 7136.4 4599.7 4639.2 4644.1 4645.4 4646.1 6437.9 6556.8 6667.7 6670.6 6675.2 6438.7 6477.9 6483.3 6507.1 6513.5 6470.9 6480.4 6487.6 6497.5 6506.0 6364.1 6387.6 6393.0 6394.6 6396.0 6370.7 6539.6 6543.4 6551.8 6571.7 6365.7 6389.3 6390.2 6396.3 6406.6 10:02:33 INFO - PROCESS | 13577 | 10:02:33 INFO - PROCESS | 13577 | [#5] yui.html Cycles:180 Average:15276.02 Median:4320.74 stddev:17644.04 (408.4%) stddev-sans-first:17660.24 10:02:33 INFO - PROCESS | 13577 | Values: 841.8 842.7 846.5 854.8 856.3 14200.6 14632.6 14651.9 14667.0 14679.5 12534.9 13396.5 13446.5 13449.9 13454.1 921.9 951.1 952.3 953.7 955.4 938.1 941.4 944.3 946.8 950.0 810.8 983.3 986.2 989.8 992.2 957.5 977.2 986.3 986.7 990.6 714.9 715.0 715.6 716.2 716.5 13794.2 13871.7 13897.7 13970.4 13995.2 14639.4 14991.0 15000.8 15032.0 15100.4 11387.1 11459.2 11487.4 11601.8 11625.6 3827.4 3878.6 3916.2 3921.1 3947.2 50913.2 51085.7 51107.7 51741.0 52093.2 10619.6 11293.8 11405.9 11446.9 11753.5 18239.8 18369.3 18406.8 18449.3 18470.3 8782.7 8803.0 8819.8 8895.5 9151.2 4594.2 4614.6 4713.6 4715.2 4762.9 3572.4 3623.0 3625.3 3629.4 3632.3 615.6 657.7 696.5 713.0 717.7 717.5 723.1 732.4 739.8 747.9 8836.3 8864.4 9143.1 9210.4 9327.0 531.7 597.1 647.1 666.4 679.5 4215.6 4306.6 4313.8 4327.7 4410.3 64998.0 65976.7 66213.7 66288.7 66620.7 56832.4 56983.7 57581.0 57719.4 57989.0 48311.8 48896.3 52109.0 52543.9 54793.5 9556.4 9838.6 10027.3 10051.0 10420.8 37630.2 38341.4 38480.2 38787.2 40070.2 45528.3 45529.3 48109.8 49094.5 49449.0 11703.8 11712.8 11833.7 12033.8 12298.8 13270.9 13659.7 13781.8 13855.1 13919.4 12813.2 12921.5 13157.7 13243.9 13701.4 12815.9 12900.0 13363.7 13449.5 13736.7 13161.9 13302.7 13508.2 13740.7 13908.4 10856.6 11059.7 11120.4 11152.7 11437.1 10887.0 11066.7 11143.8 11263.9 11264.8 10:02:33 INFO - PROCESS | 13577 | -------- Summary: end -------- 10:02:33 INFO - PROCESS | 13577 | 10:02:34 INFO - TEST-INFO | 13577: exit 0 10:02:34 INFO - TEST-OK | dromaeo_css | took 1110266ms 10:02:34 INFO - TEST-START | kraken 10:02:34 INFO - operating with platform_type : linux_ 10:02:34 INFO - Initialising browser for kraken test... 10:02:34 INFO - TEST-INFO | started process 13769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ZuaQA/profile http://localhost:52154/getInfo.html) 10:02:37 INFO - PROCESS | 13769 | __metrics Screen width/height:1600/1200 10:02:37 INFO - PROCESS | 13769 | colorDepth:24 10:02:37 INFO - PROCESS | 13769 | Browser inner width/height: 1024/697 10:02:37 INFO - PROCESS | 13769 | __metrics 10:02:38 ERROR - PROCESS | 13769 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:02:39 INFO - TEST-INFO | 13769: exit 0 10:02:39 INFO - Browser initialized. 10:02:39 INFO - Running cycle 1/1 for kraken test... 10:02:39 INFO - TEST-INFO | started process 13860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ZuaQA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:51 INFO - PROCESS | 13860 | RSS: Main: 139812864 10:02:51 INFO - PROCESS | 13860 | 10:02:53 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:54 INFO - PROCESS | 13860 | RSS: Main: 198074368 10:02:54 INFO - PROCESS | 13860 | 10:02:56 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-dft) 10:02:57 INFO - PROCESS | 13860 | RSS: Main: 185331712 10:02:57 INFO - PROCESS | 13860 | 10:03:00 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-fft) 10:03:00 INFO - PROCESS | 13860 | RSS: Main: 274067456 10:03:00 INFO - PROCESS | 13860 | 10:03:03 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52154/tests/kraken/driver.html?testName=audio-oscillator) 10:03:03 INFO - PROCESS | 13860 | RSS: Main: 181006336 10:03:03 INFO - PROCESS | 13860 | 10:03:05 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:06 INFO - PROCESS | 13860 | RSS: Main: 178995200 10:03:06 INFO - PROCESS | 13860 | 10:03:09 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:10 INFO - PROCESS | 13860 | RSS: Main: 214032384 10:03:10 INFO - PROCESS | 13860 | 10:03:13 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52154/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:13 INFO - PROCESS | 13860 | RSS: Main: 213868544 10:03:13 INFO - PROCESS | 13860 | 10:03:16 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52154/tests/kraken/driver.html?testName=json-parse-financial) 10:03:17 INFO - PROCESS | 13860 | RSS: Main: 213250048 10:03:17 INFO - PROCESS | 13860 | 10:03:18 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:19 INFO - PROCESS | 13860 | RSS: Main: 192671744 10:03:19 INFO - PROCESS | 13860 | 10:03:21 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:21 INFO - PROCESS | 13860 | RSS: Main: 198041600 10:03:21 INFO - PROCESS | 13860 | 10:03:23 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:03:24 INFO - PROCESS | 13860 | RSS: Main: 210747392 10:03:24 INFO - PROCESS | 13860 | 10:03:26 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:27 INFO - PROCESS | 13860 | RSS: Main: 217530368 10:03:27 INFO - PROCESS | 13860 | 10:03:29 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:30 INFO - PROCESS | 13860 | RSS: Main: 214384640 10:03:30 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | Cycle 1(1): loaded http://localhost:52154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52154/tests/kraken/driver.html?testName=ai-astar) 10:03:32 INFO - PROCESS | 13860 | RSS: Main: 274849792 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | __start_tp_report 10:03:32 INFO - PROCESS | 13860 | _x_x_mozilla_page_load 10:03:32 INFO - PROCESS | 13860 | _x_x_mozilla_page_load_details 10:03:32 INFO - PROCESS | 13860 | |i|pagename|runs| 10:03:32 INFO - PROCESS | 13860 | |0;ai-astar;111;112;112;108;110;112;106;109;110;109 10:03:32 INFO - PROCESS | 13860 | |1;audio-beat-detection;155;126;156;178;126;158;157;134;183;126 10:03:32 INFO - PROCESS | 13860 | |2;audio-dft;161;161;165;161;161;161;161;160;161;161 10:03:32 INFO - PROCESS | 13860 | |3;audio-fft;76;77;76;184;77;77;77;78;162;78 10:03:32 INFO - PROCESS | 13860 | |4;audio-oscillator;92;93;165;93;92;93;151;92;95;152 10:03:32 INFO - PROCESS | 13860 | |5;imaging-gaussian-blur;116;124;117;117;117;117;116;117;117;116 10:03:32 INFO - PROCESS | 13860 | |6;imaging-darkroom;147;147;146;146;147;147;146;145;145;147 10:03:32 INFO - PROCESS | 13860 | |7;imaging-desaturate;95;94;95;95;95;95;96;95;95;95 10:03:32 INFO - PROCESS | 13860 | |8;json-parse-financial;56;53;55;57;56;57;56;83;53;53 10:03:32 INFO - PROCESS | 13860 | |9;json-stringify-tinderbox;60;59;58;60;59;59;58;59;57;59 10:03:32 INFO - PROCESS | 13860 | |10;stanford-crypto-aes;73;73;73;73;73;73;74;74;76;75 10:03:32 INFO - PROCESS | 13860 | |11;stanford-crypto-ccm;116;114;112;114;113;114;113;122;129;133 10:03:32 INFO - PROCESS | 13860 | |12;stanford-crypto-pbkdf2;167;162;159;163;163;161;158;159;159;158 10:03:32 INFO - PROCESS | 13860 | |13;stanford-crypto-sha256-iterative;69;68;66;68;67;68;67;69;70;68 10:03:32 INFO - PROCESS | 13860 | __end_tp_report 10:03:32 INFO - PROCESS | 13860 | __start_cc_report 10:03:32 INFO - PROCESS | 13860 | _x_x_mozilla_cycle_collect,1583 10:03:32 INFO - PROCESS | 13860 | __end_cc_report 10:03:32 INFO - PROCESS | 13860 | __startTimestamp1467133412482__endTimestamp 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | ------- Summary: start ------- 10:03:32 INFO - PROCESS | 13860 | Number of tests: 14 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.97 (1.8%) stddev-sans-first:2.05 10:03:32 INFO - PROCESS | 13860 | Values: 111.0 112.0 112.0 108.0 110.0 112.0 106.0 109.0 110.0 109.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.50 stddev:21.16 (13.5%) stddev-sans-first:22.37 10:03:32 INFO - PROCESS | 13860 | Values: 155.0 126.0 156.0 178.0 126.0 158.0 157.0 134.0 183.0 126.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 10:03:32 INFO - PROCESS | 13860 | Values: 161.0 161.0 165.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#3] audio-fft Cycles:10 Average:96.20 Median:77.00 stddev:40.81 (53.0%) stddev-sans-first:42.63 10:03:32 INFO - PROCESS | 13860 | Values: 76.0 77.0 76.0 184.0 77.0 77.0 77.0 78.0 162.0 78.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:92.50 stddev:30.73 (33.2%) stddev-sans-first:31.75 10:03:32 INFO - PROCESS | 13860 | Values: 92.0 93.0 165.0 93.0 92.0 93.0 151.0 92.0 95.0 152.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:2.37 (2.0%) stddev-sans-first:2.46 10:03:32 INFO - PROCESS | 13860 | Values: 116.0 124.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 10:03:32 INFO - PROCESS | 13860 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 145.0 145.0 147.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:03:32 INFO - PROCESS | 13860 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.00 stddev:8.96 (16.0%) stddev-sans-first:9.48 10:03:32 INFO - PROCESS | 13860 | Values: 56.0 53.0 55.0 57.0 56.0 57.0 56.0 83.0 53.0 53.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 10:03:32 INFO - PROCESS | 13860 | Values: 60.0 59.0 58.0 60.0 59.0 59.0 58.0 59.0 57.0 59.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.50 stddev:1.06 (1.4%) stddev-sans-first:1.09 10:03:32 INFO - PROCESS | 13860 | Values: 73.0 73.0 73.0 73.0 73.0 73.0 74.0 74.0 76.0 75.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:115.00 stddev:7.45 (6.5%) stddev-sans-first:7.87 10:03:32 INFO - PROCESS | 13860 | Values: 116.0 114.0 112.0 114.0 113.0 114.0 113.0 122.0 129.0 133.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:2.88 (1.8%) stddev-sans-first:2.05 10:03:32 INFO - PROCESS | 13860 | Values: 167.0 162.0 159.0 163.0 163.0 161.0 158.0 159.0 159.0 158.0 10:03:32 INFO - PROCESS | 13860 | 10:03:32 INFO - PROCESS | 13860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 10:03:32 INFO - PROCESS | 13860 | Values: 69.0 68.0 66.0 68.0 67.0 68.0 67.0 69.0 70.0 68.0 10:03:32 INFO - PROCESS | 13860 | -------- Summary: end -------- 10:03:32 INFO - PROCESS | 13860 | 10:03:33 INFO - TEST-INFO | 13860: exit 0 10:03:33 INFO - TEST-OK | kraken | took 59262ms 10:03:33 INFO - SUITE-END | took 1169s 10:03:33 INFO - Completed test suite (00:19:29) 10:03:33 INFO - javascript benchmark 10:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.2897926945707, 3347.7991320520755, 3371.1235078879486, 3378.1385746634605, 3387.6442973487783, 5513.889722205554, 5517.889642207154, 5532.751026203815, 5540.445955404458, 5545.833624991256, 5482.506574408302, 5515.696636684981, 5541.861453463665, 5566.165075238716, 5570.442955704428, 4903.0, 4956.083124621948, 5064.0, 5098.082345177866, 5131.076406246874, 4895.8776030599165, 4949.628777841658, 4990.575801056914, 5019.121653710605, 5031.698098114125, 4991.450940396553, 5029.195328747401, 5035.093683137034, 5051.292819005343, 5073.239014147871, 5069.771860266297, 5073.644844860843, 5084.51697088776, 5089.160288552384, 5120.052790233782, 4893.584045356149, 4938.654294199408, 4993.775280112403, 5010.423801262865, 5053.772580233862, 5418.485243901862, 5423.538999185074, 5427.023135835548, 5437.918431223535, 5438.129899216146, 5841.3282472515775, 5873.706314684291, 5877.206577112078, 5881.764729410818, 5885.234919460486, 5793.681347525884, 5808.4772370486435, 5862.794802181946, 5888.087346461305, 5911.852203694899, 5519.751611177467, 5524.8342549723175, 5528.419515950848, 5531.25328080708, 5532.917006244869, 5998.580099393001, 5999.670018148957, 6001.63990160583, 6006.399360064046, 6035.8792824143275, 5690.829275121753, 5760.6543607382855, 5777.19119323295, 5828.154917537018, 5869.765209391577, 5866.0, 5869.090291004901, 5876.294844618673, 5878.059510478303, 5878.177055212273, 5763.94236057634, 5849.824505264849, 5855.912161317584, 5856.590038697335, 5863.120531920161, 5783.334916484574, 5862.296524417097, 5875.529957603381, 5908.527317814564, 5917.644941303535, 4469.486009108994, 4474.418325617714, 4477.843275485342, 4479.619232365286, 4481.148581769454, 3981.6615587675374, 3996.84012639497, 4030.858919937788, 4043.332850079763, 4064.8577299794956, 5720.856978575485, 5727.513161381329, 5747.683877386784, 5756.884862302731, 5788.507976821933, 5916.615419997686, 5935.703214839241, 5950.137230101611, 5952.136940143655, 5954.07711804671, 5481.725913704299, 5621.494065534122, 5727.885442291131, 5745.798897038583, 5758.049921762862, 5020.397552293675, 5023.321851550067, 5031.22016087507, 5046.646734728533, 5047.646664733434, 6149.446549810538, 6165.352637973038, 6167.352427994996, 6173.56785025044, 6175.84560385994, 5724.284464441945, 5880.088586269135, 5893.2928048633585, 5923.822285331447, 5998.070299103646, 6198.6280823150755, 6214.130021797043, 6239.0, 6242.438180563771, 6255.655938923403, 5829.621074630305, 5849.356570777296, 5854.209681692917, 5857.26784151981, 5885.852853678693, 5727.828165155052, 5805.94194058054, 5892.94107058924, 5897.262842144732, 5924.763009479745, 5768.913466297925, 5778.16216648592, 5782.161586570008, 5787.652740835563, 5789.044807606698, 5716.5998380113, 5760.366359700346, 5763.884722305615, 5783.132530120347, 5786.826395208151, 5516.14499752539, 5649.293838270216, 5702.857428564319, 5715.828255207589, 5740.311162660508, 5701.828945131652, 5728.427157284238, 5729.169270455844, 5729.427057294237, 5734.856628584319, 5635.098384258499, 5636.182753500638, 5640.041192997118, 5642.125470552071, 5645.1532270159805], "value": 5446.676676121749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.5367569539167, 673.5588189735722, 688.0401839433989, 748.4498893313414, 758.9354904833085, 33155.17112072199, 33914.1521461963, 33928.32143357131, 33930.32139357214, 33961.32077358451, 33686.831565842134, 40160.99999999993, 40889.0, 41030.58969410305, 41071.38392924101, 8894.733158005254, 9037.051109633492, 9043.095690430937, 9044.819103617923, 9049.321300902426, 8346.499210047386, 8605.182507661762, 8651.221390074892, 8697.173768491983, 8755.25580325673, 10843.240973131884, 11163.051140653055, 11163.274387164809, 11168.609098681547, 11184.496697648625, 10563.049325560698, 10669.786604267949, 10670.199735019827, 10670.51982660782, 10677.359358438518, 10394.324368915995, 10522.368657880552, 10527.0, 10528.0, 10535.473226338729, 40643.390349144785, 41011.17977640431, 41046.79476602628, 41121.58878411208, 41164.0, 3597.6582224688614, 3615.5842078161086, 3665.6151104134215, 3709.55485341758, 4159.729617574848, 33520.32959340824, 34191.658083419345, 34246.65753342485, 34487.13782155441, 34692.30615387678, 3917.98041009796, 3943.0, 3946.269940061069, 4071.8982025449304, 4116.217918595487, 329668.0, 329695.0, 330981.0, 331226.0, 332601.99999999756, 64136.0, 64152.0, 64552.35447645463, 64569.67715161394, 64596.0, 68229.65885170542, 70816.291837082, 71659.6417017922, 71724.0, 71785.2821471789, 17926.91036544809, 18282.177302021442, 18346.541336466697, 18351.54121146982, 18353.90823045903, 12998.415071321813, 13000.0, 13004.0, 13008.739825203444, 13019.088663793444, 18987.71518427225, 20801.58396832085, 21057.57884842325, 21302.893485532473, 21464.141434342764, 7467.2421458580075, 7548.773536793905, 7559.962200189074, 7803.492772969739, 7838.216178382117, 1137.732632831284, 1155.174050553858, 1171.4611278811672, 1229.3361584744139, 1284.441268048402, 33044.83477582597, 33335.33329333448, 33568.66431335704, 33798.49302260468, 33996.32007359839, 1208.1542919956066, 1214.9817752733538, 1258.2010423381219, 1279.7248591552861, 1292.011611117496, 17133.97196168234, 17853.116363527377, 17888.55278618045, 18109.7283540747, 18506.907465462587, 463911.0, 467206.0, 469386.0, 470576.0, 472179.0, 64418.35581644217, 64590.0, 65023.34976650267, 65441.69116617641, 65489.345106548324, 1522.2312732070234, 1529.0825504697093, 1541.6454215530491, 1543.7221300165854, 1552.3247387386298, 29156.27109322284, 31027.970676143417, 32901.0, 33107.0, 33350.16624584308, 52382.47617523776, 53103.4689653114, 53377.46622533725, 53405.0, 53456.198157028455, 361914.0, 370809.0, 370878.0, 370899.0, 371061.0, 27374.0, 29704.702952970194, 29993.70006299909, 30023.84988075133, 30273.24316892095, 47087.0, 47352.7632361836, 47602.285965711235, 48450.0, 48526.5147348522, 39837.40243896402, 39933.201335973696, 40118.398224027245, 40414.79792601018, 41233.0, 37888.62111378961, 38491.0, 38585.2282954345, 38717.6128238714, 39251.214975700896, 39824.362522091826, 40493.39259911163, 41010.589894100674, 41533.1693366125, 41566.79216603898, 33036.50445243371, 35207.64792352044, 35286.47070293896, 35486.46770298499, 36003.45994810132, 28042.71957280401, 28222.71777282283, 28240.576391353734, 28444.85777571099, 28553.714462855107], "value": 20739.34548285306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.5835094081389, 422.54787377506074, 429.8796337025634, 433.32185130271125, 436.8842256801946, 18488.26046958122, 19083.809161908375, 19251.518712032208, 19290.710639340403, 20071.0, 13183.736325273489, 13194.472221111144, 13214.735705285888, 18442.44672659819, 19909.104090315934, 5165.5092766187245, 5342.572594192475, 5385.084535628933, 5399.892002159954, 5401.378841433227, 5760.913586296209, 5787.623804452697, 5815.418458154193, 5831.708414579254, 5843.655959129403, 5478.096114141162, 5783.855403614923, 5785.913211301834, 5787.421257874221, 5797.072468405056, 5350.30446042014, 5362.383325917492, 5369.9463005369835, 5381.7578208980685, 5386.434424385442, 5241.50205730455, 5245.134552798783, 5254.264402983586, 5255.842324730264, 5262.657927234717, 21520.139194432202, 22670.886645566665, 22989.0, 23413.297601071994, 23495.530089398286, 2531.6076008218756, 2631.25009372328, 2637.7626013658864, 2838.963778220955, 2884.9614138909974, 10186.796264074677, 10236.948815255875, 10940.23418360715, 11634.418279086096, 14191.361388737532, 2019.121682068305, 2028.1177687705895, 2033.8677985931015, 2048.6619707748355, 2068.720722702446, 79005.0, 79196.60401698013, 81542.59228703819, 82842.58578707128, 83164.0, 11103.666889993314, 11352.0, 11528.944829620157, 11547.364894930692, 11760.705982350339, 16149.273282702306, 16166.595835104217, 16185.595360115856, 16312.184390780414, 16312.918435407748, 8683.956580217058, 8986.337527557424, 8989.325800564984, 9007.153533525743, 9060.592273347715, 8726.389152759246, 8804.735857924272, 8815.471071735716, 8846.424982376126, 8859.06979767115, 4831.589314908272, 4954.529319714621, 5002.449730529639, 5043.394792624908, 5071.239314102914, 1878.727584500267, 1918.3957053528095, 2042.7548694156797, 2075.9792402076087, 2112.271266413085, 1035.8705161854768, 1061.0662616897082, 1087.380193289833, 1099.2415233488866, 1101.7741363020723, 18085.499445781385, 18689.158987845578, 18795.0, 18925.526861828563, 18949.0, 1069.0912724184536, 1082.7022568793486, 1099.9395033273247, 1115.0967716149783, 1126.695792136135, 10174.389536627827, 10640.0, 10654.893451065545, 10676.62631807883, 10741.83887241692, 496207.0, 503535.0, 507148.0, 509608.0, 521158.0, 66530.0, 76037.61981190059, 78798.21201788023, 91106.0, 93138.0, 1061.932757578644, 1061.9734506637242, 1076.6662334676275, 1089.4716062709579, 1093.8742044664966, 13275.468981240641, 16137.515874523782, 16298.0, 16611.83388166103, 16873.240704168587, 33989.0, 35262.0, 35479.467807982386, 36171.45742813807, 36284.45573316349, 51065.74467127641, 52210.47789522056, 52887.0, 53681.19478207908, 54180.74915504925, 8866.42368246062, 8894.68868589622, 8921.286297096347, 8962.417442866194, 9059.411138275991, 9733.13337372257, 12968.221906685629, 13098.803517947048, 13257.204567725967, 13515.932420337835, 11431.256968297033, 11611.477483513094, 11703.76592468163, 11779.52881884715, 11818.881811181778, 11360.1479889007, 11422.200445968703, 11533.077353811843, 11546.48040838181, 11608.30350178992, 10945.631077649117, 11479.885201147881, 11698.0, 11835.526578936746, 12007.879921200676, 8622.61198246068, 8652.524111173945, 8995.100489950952, 9022.819543608959, 9110.407823491452, 8735.344849136467, 10938.671839844817, 11388.544458221579, 11495.367754773568, 11496.597619083292], "value": 9234.081214213536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.7194989052298, 1553.9300731467083, 1568.4510421352525, 1792.336835370913, 1976.1305025788652, 8275.255227029566, 8579.099194584573, 8580.528070956096, 8583.184597463247, 8585.527795971218, 8326.084130745614, 8483.109273526283, 8497.490150590953, 8504.872426913602, 8515.0, 2369.336585755991, 2395.9281221563383, 2398.736139024706, 2401.2556107606697, 2401.2916189723987, 2410.0, 2422.685050943375, 2437.5734246506877, 2470.629405589167, 2483.242611003652, 2365.5387199496104, 2381.5951288281035, 2405.434722840131, 2409.5301416223756, 2426.0538390027905, 2362.65741467488, 2402.3633737059695, 2415.9758402416014, 2427.8786060696893, 2432.598621227495, 2365.586022446082, 2410.433548116191, 2414.2515820095828, 2432.221689059502, 2435.634654801794, 7434.814129646802, 7605.0, 8598.0, 8661.783455413664, 8681.131886811332, 5091.974540127313, 5185.403678576937, 5185.922211166798, 5197.636165468419, 5202.505761952609, 3270.5421241026274, 3275.7215636670912, 3311.304626028537, 3350.949735753966, 3371.865125394981, 1056.873175218971, 2062.61841559312, 2068.079704531484, 2098.664213725812, 2110.5673336965883, 12151.878481215163, 12238.204516706475, 12239.755204895851, 12274.38628068593, 12298.569550065704, 4350.825966961286, 4406.25093734066, 4463.397441345377, 4466.731996080245, 4594.701344412602, 9709.514524273758, 9799.608015679292, 9802.411855288705, 9814.803703925882, 9815.607375705034, 5300.628955973045, 5315.202719592015, 5350.277712508761, 5355.196720491879, 5385.784568617211, 4917.680350777188, 4960.032793605213, 4962.925556116661, 4964.106460837012, 4971.130052240844, 3653.2328211075974, 3814.9427758583643, 3842.615738426135, 3871.1483473635753, 3871.9419208711893, 1132.4337831084458, 1156.942152892352, 1158.472894832849, 1164.0745607242093, 1175.4710380328886, 817.5748610722391, 885.57049830832, 941.750436134425, 971.0968799016982, 1010.5604062232952, 5706.430731548858, 5810.0, 5812.854678632983, 5877.882442351214, 5921.467067963904, 946.2477330522114, 1044.6552637629563, 1045.4877110216091, 1045.9058684718411, 1062.6758838554315, 4046.716729828943, 4049.0687141957515, 4062.857799976987, 4074.4295798588223, 4149.398337241083, 10187.337823041627, 10663.466826658636, 10694.197935154894, 10847.51186196623, 10872.130229581773, 10393.84409233862, 10549.0, 10595.311304765166, 10648.840267395995, 10651.041406273473, 8429.0, 8494.787630309169, 8572.742817715478, 8581.01318348398, 8581.141885811368, 5830.416958304136, 5887.116932459994, 5912.46787789101, 5939.376365481735, 6036.245469316335, 9587.952060239653, 9630.951845240728, 9653.855192171983, 9655.855162172433, 9809.950950245204, 9516.571754271214, 9748.756281093029, 9832.360896541702, 10080.596776129167, 10082.495875206358, 7242.311980361857, 7309.780706578811, 7351.8162045949275, 7424.034875466371, 7431.479796414199, 8027.919720802717, 8227.670893164446, 8242.17578242195, 8252.711155109542, 8255.25702686761, 7388.778336649909, 7502.962485187539, 7526.134494533198, 7692.653830577749, 7826.0, 7593.734219302298, 7634.847303054019, 7648.617569121633, 7664.73173438927, 7674.117476490275, 6614.239362473185, 6713.160854893138, 6725.125733654593, 6734.0, 6746.595204287759, 4108.842857499836, 4954.851354459372, 5013.448520662797, 5038.269450929522, 5089.643724939367, 5056.494350565061, 5123.92314115296, 5138.3833939927445, 5143.0, 5254.65844720092], "value": 4658.717377197261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.4935368392672, 351.80650642146827, 353.4980327934333, 363.1683444911153, 365.7531166462638, 5929.614575052618, 5930.673812940287, 5958.523318134549, 5962.463378295953, 5998.130271110686, 6068.635881847081, 6133.1413602095745, 6141.0, 6145.508359331254, 6150.354212807658, 4543.295789152687, 4588.967482316469, 4665.300204969265, 4719.339292499053, 4756.690815097017, 4687.88280292992, 4706.694064885772, 4715.198416269242, 4716.009637976029, 4716.457607375144, 4682.344471773954, 4686.367340409035, 4689.132510485554, 4689.437267527885, 4694.483606803249, 4675.50907154749, 4683.086798074377, 4692.343071969944, 4693.694909830884, 4694.037722266927, 4090.5909409059154, 4109.075458021921, 4112.136451345221, 4139.130782535671, 4145.233131870614, 5755.338136114358, 5910.822675319747, 5913.8817223655715, 5914.645121292736, 5921.437463440966, 5391.73041347931, 5397.730113494349, 5400.243965844785, 5401.891962160774, 5403.7027963462, 6323.051542268697, 6349.873002539924, 6357.65032923189, 6366.267879193906, 6368.808935731936, 4421.602055814992, 4525.230710779142, 4539.273716205391, 4539.432570928634, 4540.046590216059, 6676.799696009079, 6718.563293385914, 6730.057791909087, 6745.730170793162, 6747.156605424322, 4583.747893865802, 4584.564466375689, 4586.151561961048, 4593.63250939924, 4598.724076555417, 4679.766011699469, 4680.017196388729, 4680.485146633868, 4681.9297710534365, 4688.906221875543, 5140.897182056413, 5388.272583201296, 5393.298871146804, 5403.756830942617, 5405.324334458192, 6337.144485494491, 6357.11000459936, 6359.141515895388, 6365.904511432333, 6475.190601174853, 1625.7398816189352, 1634.4606279927832, 1643.8520533152073, 1643.9424620138477, 1644.0957473389587, 1059.6026490066224, 1070.930389524694, 1092.153580974735, 1102.5424448853637, 1103.5530610102921, 6361.968190159019, 6367.076773867763, 6367.172267605274, 6375.0437434384285, 6397.872042559123, 6599.637019963948, 6602.0, 6609.438197753148, 6615.86768264632, 6637.634930078795, 6358.968205158944, 6370.617762934239, 6379.075034120026, 6387.361263873669, 6388.4569811566535, 3551.7691350062164, 3584.2831433713363, 3590.8922732318074, 3594.101474631342, 3595.5865075516126, 6876.17485901695, 7040.014397984286, 7044.788656340318, 7052.647367631598, 7055.717771289091, 6767.898481522781, 6770.898436523456, 6779.2881747416795, 6789.72841086351, 6792.45660347171, 6994.405475534535, 7007.754728584577, 7013.754518591825, 7026.92973070273, 7036.155661320572, 6607.768728094494, 6612.338766123542, 6631.834204144935, 6636.668166591555, 6676.632785196861, 6523.3150519194805, 6567.770128045496, 6651.501137414616, 6661.233958094881, 6665.966670166618, 7089.64551772399, 7108.644567771487, 7113.751018714527, 7125.287471252833, 7136.4290856730295, 4599.747013914133, 4639.188142075191, 4644.117617652635, 4645.419322584677, 4646.117237724821, 6437.935620643733, 6556.770513032021, 6667.666616669244, 6670.599764014175, 6675.198976122702, 6438.67806609677, 6477.935220647733, 6483.286838447672, 6507.056476810931, 6513.478921686159, 6470.870582588416, 6480.449161821298, 6487.578307410004, 6497.480201583957, 6505.967470162619, 6364.109024736448, 6387.552871298964, 6392.968035159981, 6394.5523813334485, 6395.968020159869, 6370.713317900613, 6539.6076235424125, 6543.378379053982, 6551.836204094936, 6571.704273307617, 6365.745370185141, 6389.2652344980925, 6390.169277993831, 6396.264429590657, 6406.647634380154], "value": 4901.393648965393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.7643059943215, 842.6755699055866, 846.4667259626434, 854.7563944275882, 856.3235044314991, 14200.573982780521, 14632.634184145401, 14651.926740366283, 14667.046641968278, 14679.486217982372, 12534.93732531336, 13396.464141434355, 13446.529371472001, 13449.865501345008, 13454.05821592489, 921.8847644044495, 951.1297163095759, 952.2953014769056, 953.7186529973675, 955.3646824861494, 938.132227689388, 941.4398432932428, 944.3200895355333, 946.8390373636498, 950.0072424316605, 810.84999275134, 983.2871168402922, 986.1568359053014, 989.8267803134459, 992.2409356842022, 957.4686049242667, 977.1889331854544, 986.344081186014, 986.7187851462371, 990.5592011554861, 714.9142102947627, 715.0347031507423, 715.5849607227796, 716.2372073741449, 716.4590733995852, 13794.241316727575, 13871.722565548733, 13897.652558686013, 13970.441182352693, 13995.16029038261, 14639.41442342305, 14991.0, 15000.774988375075, 15032.0, 15100.395984160621, 11387.08903287735, 11459.197856150073, 11487.368194749286, 11601.767964640745, 11625.59310424131, 3827.445020472044, 3878.553966293884, 3916.236333914888, 3921.117748506563, 3947.1513624570566, 50913.23630145551, 51085.744571277275, 51107.744461277456, 51741.0, 52093.218601721004, 10619.575216991389, 11293.830592541119, 11405.942970285096, 11446.853537773579, 11753.471093800628, 18239.817601824077, 18369.26522939094, 18406.81593184051, 18449.262029518668, 18470.261189552537, 8782.736517904474, 8803.0, 8819.823603527893, 8895.510746908982, 9151.17639412456, 4594.241950078266, 4614.584687378152, 4713.599344055725, 4715.198416269174, 4762.880927976828, 3572.4462708280257, 3622.9818850906104, 3625.2568223514118, 3629.4011488104165, 3632.2917031179195, 615.6183166436748, 657.7040331850686, 696.5472442912046, 713.0, 717.6519388096768, 717.4762423430925, 723.1105739939799, 732.4140687450125, 739.8261408568982, 747.9401647868158, 8836.337274704423, 8864.379493435526, 9143.13140251675, 9210.35527513081, 9326.95336523313, 531.662394379564, 597.070991147733, 647.1166857239833, 666.3736088077192, 679.4869873245767, 4215.578442155821, 4306.590873866978, 4313.762743049099, 4327.718698284664, 4410.25025745624, 64998.025029624594, 65976.67011664911, 66213.668931656, 66288.66855665787, 66620.6668966652, 56832.43167568272, 56983.71508142433, 57581.0, 57719.42280577224, 57989.0, 48311.75844120827, 48896.26655600169, 52109.0, 52543.949121017366, 54793.452065478836, 9556.426614403159, 9838.557264923238, 10027.29808913369, 10051.0, 10420.843687344544, 37630.247395052495, 38341.42487862628, 38480.23039539249, 38787.2242555153, 40070.1985960285, 45528.317075243234, 45529.317060244786, 48109.75945120252, 49094.509054908995, 49449.0, 11703.76592468163, 11712.765744685228, 11833.704157396134, 12033.819492707442, 12298.75402491963, 13270.867291326964, 13659.726805464034, 13781.793273100711, 13855.099418537762, 13919.443222270997, 12813.167144135601, 12921.547745829226, 13157.671058223621, 13243.867561324263, 13701.383437745126, 12815.871841281842, 12900.0, 13363.665908352368, 13449.529266475627, 13736.65658358509, 13161.868381316064, 13302.733945320846, 13508.189508629514, 13740.65648358799, 13908.37412316428, 10856.620018299322, 11059.668209953714, 11120.443977800916, 11152.721181970515, 11437.142214334124, 10887.032299328277, 11066.723331916766, 11143.777124457303, 11263.887361126612, 11264.774704506028], "value": 7028.219261985396, "unit": "score"}], "name": "dromaeo_css", "value": 7423.89778916819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 108.0, 110.0, 112.0, 106.0, 109.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 156.0, 178.0, 126.0, 158.0, 157.0, 134.0, 183.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 165.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 184.0, 77.0, 77.0, 77.0, 78.0, 162.0, 78.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 165.0, 93.0, 92.0, 93.0, 151.0, 92.0, 95.0, 152.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 124.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 145.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 57.0, 56.0, 57.0, 56.0, 83.0, 53.0, 53.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 60.0, 59.0, 59.0, 58.0, 59.0, 57.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 74.0, 76.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 112.0, 114.0, 113.0, 114.0, 113.0, 122.0, 129.0, 133.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 159.0, 163.0, 163.0, 161.0, 158.0, 159.0, 159.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 69.0, 70.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1525.1000000000001, "alertThreshold": 2.0}]} 10:03:33 INFO - Return code: 0 10:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:03:33 ERROR - # TBPL SUCCESS # 10:03:33 INFO - Running post-action listener: _resource_record_post_action 10:03:33 INFO - Running post-run listener: _resource_record_post_run 10:03:34 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 453287936; Read time: 24; Write time: 392632 10:03:34 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242659328; Read time: 0; Write time: 252092 10:03:34 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 210628608; Read time: 24; Write time: 140540 10:03:34 INFO - Running post-run listener: _upload_blobber_files 10:03:34 INFO - Blob upload gear active. 10:03:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:03:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:03:35 INFO - (blobuploader) - INFO - Open directory for files ... 10:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:36 INFO - (blobuploader) - INFO - Done attempting. 10:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:36 INFO - (blobuploader) - INFO - Done attempting. 10:03:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:03:36 INFO - Return code: 0 10:03:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:03:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:03:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60daacd8d7274e2b3cdc342c50045fcfaebe9f18af3d90840a440ce532ddcfaf137b6315de0ee592efe66697c1b13b3837b6c84f03ca269db65fd91ece68945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07341338ceaf9ac250f65e3350a24003c53a731345ea282abfff45106ef099b72cff3b7c980b8f0bb3b623eaca12cc7149f8c99f6a3ca69cc0c5f439772e2364"} 10:03:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:03:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:03:36 INFO - Contents: 10:03:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60daacd8d7274e2b3cdc342c50045fcfaebe9f18af3d90840a440ce532ddcfaf137b6315de0ee592efe66697c1b13b3837b6c84f03ca269db65fd91ece68945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07341338ceaf9ac250f65e3350a24003c53a731345ea282abfff45106ef099b72cff3b7c980b8f0bb3b623eaca12cc7149f8c99f6a3ca69cc0c5f439772e2364"} 10:03:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:03:36 INFO - Copying logs to upload dir... 10:03:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:03:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.666988 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-28 10:03:36.589930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:03:36.593533) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60daacd8d7274e2b3cdc342c50045fcfaebe9f18af3d90840a440ce532ddcfaf137b6315de0ee592efe66697c1b13b3837b6c84f03ca269db65fd91ece68945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07341338ceaf9ac250f65e3350a24003c53a731345ea282abfff45106ef099b72cff3b7c980b8f0bb3b623eaca12cc7149f8c99f6a3ca69cc0c5f439772e2364"} build_url:https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/GjUDOXcFT6Wi-K_a7wdVhw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60daacd8d7274e2b3cdc342c50045fcfaebe9f18af3d90840a440ce532ddcfaf137b6315de0ee592efe66697c1b13b3837b6c84f03ca269db65fd91ece68945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07341338ceaf9ac250f65e3350a24003c53a731345ea282abfff45106ef099b72cff3b7c980b8f0bb3b623eaca12cc7149f8c99f6a3ca69cc0c5f439772e2364"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:03:36.622504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:03:36.622830) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467132193.174940-1216345817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:03:36.703174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:03:36.703705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:03:36.704353) ========= ========= Total master_lag: 0.18 =========