builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1461331653.23 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.225666) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.226156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.226440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.242505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.242767) ========= 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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 43.0M=0s 2016-04-22 06:27:33 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.371069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.371431) ========= 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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.421302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:33.421690) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:27:33,992 truncating revision to first 12 chars 2016-04-22 06:27:33,992 Setting DEBUG logging. 2016-04-22 06:27:33,992 attempt 1/10 2016-04-22 06:27:33,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:27:34,258 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644766 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:34.079764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:34.080140) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:34.080573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:34.080846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:27:34.090093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-22 06:27:34.090483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:27:34 INFO - MultiFileLogger online at 20160422 06:27:34 in /builds/slave/test 06:27:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:34 INFO - {'append_to_log': False, 06:27:34 INFO - 'base_work_dir': '/builds/slave/test', 06:27:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:34 INFO - 'branch': 'Fx-Team-Non-PGO', 06:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:34 INFO - 'config_files': ('talos/linux_config.py',), 06:27:34 INFO - 'default_actions': ('clobber', 06:27:34 INFO - 'read-buildbot-config', 06:27:34 INFO - 'download-and-extract', 06:27:34 INFO - 'populate-webroot', 06:27:34 INFO - 'create-virtualenv', 06:27:34 INFO - 'install', 06:27:34 INFO - 'run-tests'), 06:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:34 INFO - 'download_minidump_stackwalk': True, 06:27:34 INFO - 'download_symbols': 'ondemand', 06:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:34 INFO - 'installer_path': 'installer.exe', 06:27:34 INFO - 'log_level': 'info', 06:27:34 INFO - 'log_name': 'talos', 06:27:34 INFO - 'log_to_console': True, 06:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:27:34 INFO - 'opt_config_files': (), 06:27:34 INFO - 'pip_index': False, 06:27:34 INFO - 'sps_profile': False, 06:27:34 INFO - 'sps_profile_interval': 0, 06:27:34 INFO - 'suite': 'dromaeojs', 06:27:34 INFO - 'system_bits': '32', 06:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:34 INFO - 'title': 'talos-linux64-ix-003', 06:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:34 INFO - 'use_talos_json': True, 06:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:34 INFO - 'work_dir': 'build'} 06:27:34 INFO - ##### 06:27:34 INFO - ##### Running clobber step. 06:27:34 INFO - ##### 06:27:34 INFO - Running pre-action listener: _resource_record_pre_action 06:27:34 INFO - Running main action method: clobber 06:27:34 INFO - rmtree: /builds/slave/test/build 06:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:35 INFO - Running post-action listener: _resource_record_post_action 06:27:35 INFO - ##### 06:27:35 INFO - ##### Running read-buildbot-config step. 06:27:35 INFO - ##### 06:27:35 INFO - Running pre-action listener: _resource_record_pre_action 06:27:35 INFO - Running main action method: read_buildbot_config 06:27:35 INFO - Using buildbot properties: 06:27:35 INFO - { 06:27:35 INFO - "project": "", 06:27:35 INFO - "product": "firefox", 06:27:35 INFO - "script_repo_revision": "production", 06:27:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:27:35 INFO - "repository": "", 06:27:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:27:35 INFO - "buildid": "20160419211331", 06:27:35 INFO - "pgo_build": "False", 06:27:35 INFO - "basedir": "/builds/slave/test", 06:27:35 INFO - "buildnumber": 2863, 06:27:35 INFO - "slavename": "talos-linux64-ix-003", 06:27:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:27:35 INFO - "platform": "ubuntu64_hw", 06:27:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:27:35 INFO - "branch": "fx-team", 06:27:35 INFO - "repo_path": "integration/fx-team", 06:27:35 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 06:27:35 INFO - "stage_platform": "linux64", 06:27:35 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 06:27:35 INFO - "slavebuilddir": "test" 06:27:35 INFO - } 06:27:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:27:35 INFO - Running post-action listener: _resource_record_post_action 06:27:35 INFO - ##### 06:27:35 INFO - ##### Running download-and-extract step. 06:27:35 INFO - ##### 06:27:35 INFO - Running pre-action listener: _resource_record_pre_action 06:27:35 INFO - Running main action method: download_and_extract 06:27:35 INFO - mkdir: /builds/slave/test/build/tests 06:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:35 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:27:37 INFO - Downloaded 1361 bytes. 06:27:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:27:37 INFO - Using the following test package requirements: 06:27:37 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:27:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:27:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'jsshell-linux-x86_64.zip'], 06:27:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:27:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:27:37 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:27:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:27:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:27:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:27:37 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')]} 06:27:37 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:27:38 INFO - Downloaded 22267191 bytes. 06:27:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:27:40 INFO - Return code: 0 06:27:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:40 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:27:41 INFO - Downloaded 22267191 bytes. 06:27:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:27:42 INFO - Return code: 0 06:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:42 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:27:43 INFO - Downloaded 10845952 bytes. 06:27:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:27:43 INFO - Return code: 0 06:27: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')]} 06:27:43 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:27:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:27:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:27:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:27:45 INFO - Downloaded 54508588 bytes. 06:27:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:27:45 INFO - mkdir: /builds/slave/test/properties 06:27:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:45 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:45 INFO - Contents: 06:27:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:27:53 INFO - Running post-action listener: _resource_record_post_action 06:27:53 INFO - Running post-action listener: set_extra_try_arguments 06:27:53 INFO - ##### 06:27:53 INFO - ##### Running populate-webroot step. 06:27:53 INFO - ##### 06:27:53 INFO - Running pre-action listener: _resource_record_pre_action 06:27:53 INFO - Running main action method: populate_webroot 06:27:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:53 INFO - '--tppagecycles', 06:27:53 INFO - '7'], 06:27:53 INFO - 'tests': ['tsvgm']}}, 06:27:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:27:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:27:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['damp', 'tps']}, 06:27:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'tests': ['damp', 'tps']}, 06:27:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['dromaeo_dom']}, 06:27:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['a11yr', 06:27:53 INFO - 'ts_paint', 06:27:53 INFO - 'tpaint', 06:27:53 INFO - 'sessionrestore', 06:27:53 INFO - 'sessionrestore_no_auto_restore', 06:27:53 INFO - 'tabpaint']}, 06:27:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['tsvgx', 06:27:53 INFO - 'tsvgr_opacity', 06:27:53 INFO - 'tart', 06:27:53 INFO - 'tscrollx', 06:27:53 INFO - 'cart']}, 06:27:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:27:53 INFO - 'tsvgr_opacity', 06:27:53 INFO - 'tart', 06:27:53 INFO - 'tscrollx', 06:27:53 INFO - 'cart']}, 06:27:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'talos_options': ['--disable-e10s'], 06:27:53 INFO - 'tests': ['tp5o']}, 06:27:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'tests': ['tp5o']}, 06:27:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'talos_options': ['--disable-e10s', 06:27:53 INFO - '--xperf_path', 06:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:53 INFO - 'tests': ['tp5n']}, 06:27:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:53 INFO - 'talos_options': ['--xperf_path', 06:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:53 INFO - 'tests': ['tp5n']}}, 06:27:53 INFO - 'talos.zip': {'path': '', 06:27:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:53 INFO - Running post-action listener: _resource_record_post_action 06:27:53 INFO - ##### 06:27:53 INFO - ##### Running create-virtualenv step. 06:27:53 INFO - ##### 06:27:53 INFO - Running pre-action listener: _resource_record_pre_action 06:27:53 INFO - Running main action method: create_virtualenv 06:27:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:53 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 06:27:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:53 INFO - Using real prefix '/usr' 06:27:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:55 INFO - Installing pip.................done. 06:27:55 INFO - Return code: 0 06:27:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:27:55 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 06:27:55 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 06:27:55 INFO - Using env: {'DISPLAY': ':0', 06:27:55 INFO - 'HOME': '/home/cltbld', 06:27:55 INFO - 'LANG': 'en_US.UTF-8', 06:27:55 INFO - 'LANGUAGE': 'en_US:en', 06:27:55 INFO - 'LOGNAME': 'cltbld', 06:27:55 INFO - 'MAIL': '/var/mail/cltbld', 06:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:55 INFO - 'MOZ_NO_REMOTE': '1', 06:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:55 INFO - 'NO_EM_RESTART': '1', 06:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:55 INFO - 'PWD': '/builds/slave/test', 06:27:55 INFO - 'SHELL': '/bin/bash', 06:27:55 INFO - 'SHLVL': '1', 06:27:55 INFO - 'TERM': 'linux', 06:27:55 INFO - 'TMOUT': '86400', 06:27:55 INFO - 'USER': 'cltbld', 06:27:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:55 INFO - '_': '/tools/buildbot/bin/python'} 06:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:56 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 06:27:56 INFO - Cleaning up... 06:27:56 INFO - Return code: 0 06:27:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:27:56 INFO - Using env: {'DISPLAY': ':0', 06:27:56 INFO - 'HOME': '/home/cltbld', 06:27:56 INFO - 'LANG': 'en_US.UTF-8', 06:27:56 INFO - 'LANGUAGE': 'en_US:en', 06:27:56 INFO - 'LOGNAME': 'cltbld', 06:27:56 INFO - 'MAIL': '/var/mail/cltbld', 06:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:56 INFO - 'MOZ_NO_REMOTE': '1', 06:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:56 INFO - 'NO_EM_RESTART': '1', 06:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:56 INFO - 'PWD': '/builds/slave/test', 06:27:56 INFO - 'SHELL': '/bin/bash', 06:27:56 INFO - 'SHLVL': '1', 06:27:56 INFO - 'TERM': 'linux', 06:27:56 INFO - 'TMOUT': '86400', 06:27:56 INFO - 'USER': 'cltbld', 06:27:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:56 INFO - '_': '/tools/buildbot/bin/python'} 06:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:56 INFO - Downloading/unpacking psutil>=0.7.1 06:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:58 INFO - Installing collected packages: psutil 06:27:58 INFO - Running setup.py install for psutil 06:27:58 INFO - building 'psutil._psutil_linux' extension 06:27:58 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 06:27:58 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 06:27:58 INFO - building 'psutil._psutil_posix' extension 06:27:58 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 06:27:58 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 06:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:58 INFO - Successfully installed psutil 06:27:58 INFO - Cleaning up... 06:27:58 INFO - Return code: 0 06:27:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:27:58 INFO - Using env: {'DISPLAY': ':0', 06:27:58 INFO - 'HOME': '/home/cltbld', 06:27:58 INFO - 'LANG': 'en_US.UTF-8', 06:27:58 INFO - 'LANGUAGE': 'en_US:en', 06:27:58 INFO - 'LOGNAME': 'cltbld', 06:27:58 INFO - 'MAIL': '/var/mail/cltbld', 06:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:58 INFO - 'MOZ_NO_REMOTE': '1', 06:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:58 INFO - 'NO_EM_RESTART': '1', 06:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:58 INFO - 'PWD': '/builds/slave/test', 06:27:58 INFO - 'SHELL': '/bin/bash', 06:27:58 INFO - 'SHLVL': '1', 06:27:58 INFO - 'TERM': 'linux', 06:27:58 INFO - 'TMOUT': '86400', 06:27:58 INFO - 'USER': 'cltbld', 06:27:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:58 INFO - '_': '/tools/buildbot/bin/python'} 06:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:28:01 INFO - Installing collected packages: mozsystemmonitor 06:28:01 INFO - Running setup.py install for mozsystemmonitor 06:28:01 INFO - Successfully installed mozsystemmonitor 06:28:01 INFO - Cleaning up... 06:28:01 INFO - Return code: 0 06:28:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:28:01 INFO - Using env: {'DISPLAY': ':0', 06:28:01 INFO - 'HOME': '/home/cltbld', 06:28:01 INFO - 'LANG': 'en_US.UTF-8', 06:28:01 INFO - 'LANGUAGE': 'en_US:en', 06:28:01 INFO - 'LOGNAME': 'cltbld', 06:28:01 INFO - 'MAIL': '/var/mail/cltbld', 06:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:01 INFO - 'MOZ_NO_REMOTE': '1', 06:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:01 INFO - 'NO_EM_RESTART': '1', 06:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:01 INFO - 'PWD': '/builds/slave/test', 06:28:01 INFO - 'SHELL': '/bin/bash', 06:28:01 INFO - 'SHLVL': '1', 06:28:01 INFO - 'TERM': 'linux', 06:28:01 INFO - 'TMOUT': '86400', 06:28:01 INFO - 'USER': 'cltbld', 06:28:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:01 INFO - '_': '/tools/buildbot/bin/python'} 06:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 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 06:28:03 INFO - Downloading docopt-0.6.1.tar.gz 06:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:04 INFO - Running setup.py install for blobuploader 06:28:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:04 INFO - Running setup.py install for requests 06:28:04 INFO - Running setup.py install for docopt 06:28:04 INFO - Successfully installed blobuploader requests docopt 06:28:04 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:04 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 06:28:04 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 06:28:04 INFO - Using env: {'DISPLAY': ':0', 06:28:04 INFO - 'HOME': '/home/cltbld', 06:28:04 INFO - 'LANG': 'en_US.UTF-8', 06:28:04 INFO - 'LANGUAGE': 'en_US:en', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MAIL': '/var/mail/cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SHLVL': '1', 06:28:04 INFO - 'TERM': 'linux', 06:28:04 INFO - 'TMOUT': '86400', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - '_': '/tools/buildbot/bin/python'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:04 INFO - Running setup.py (path:/tmp/pip-1WuXex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:04 INFO - Running setup.py (path:/tmp/pip-RQ87if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:05 INFO - Running setup.py (path:/tmp/pip-6Hqn7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:05 INFO - Running setup.py (path:/tmp/pip-IuBL3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:05 INFO - Running setup.py (path:/tmp/pip-kbkv1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:05 INFO - Running setup.py (path:/tmp/pip-BBBUZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:05 INFO - Running setup.py (path:/tmp/pip-Zu4YeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:05 INFO - Running setup.py (path:/tmp/pip-MzeuNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:05 INFO - Running setup.py (path:/tmp/pip-u2A1Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:05 INFO - Running setup.py (path:/tmp/pip-y_dk0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:05 INFO - Running setup.py (path:/tmp/pip-t6cKVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:05 INFO - Running setup.py (path:/tmp/pip-aDRsE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:05 INFO - Running setup.py (path:/tmp/pip-4eNISk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:05 INFO - Running setup.py (path:/tmp/pip-DC2P3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:05 INFO - Running setup.py (path:/tmp/pip-XtsJfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:05 INFO - Running setup.py (path:/tmp/pip-Tpk2L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:06 INFO - Running setup.py (path:/tmp/pip-6AQ5SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:06 INFO - Running setup.py install for manifestparser 06:28:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Running setup.py install for mozcrash 06:28:06 INFO - Running setup.py install for mozdebug 06:28:06 INFO - Running setup.py install for mozdevice 06:28:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Running setup.py install for mozfile 06:28:06 INFO - Running setup.py install for mozhttpd 06:28:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Running setup.py install for mozinfo 06:28:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Running setup.py install for mozInstall 06:28:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:06 INFO - Running setup.py install for mozleak 06:28:06 INFO - Running setup.py install for mozlog 06:28:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Running setup.py install for moznetwork 06:28:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Running setup.py install for mozprocess 06:28:07 INFO - Running setup.py install for mozprofile 06:28:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Running setup.py install for mozrunner 06:28:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Running setup.py install for mozscreenshot 06:28:07 INFO - Running setup.py install for moztest 06:28:07 INFO - Running setup.py install for mozversion 06:28:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:07 INFO - Cleaning up... 06:28:07 INFO - Return code: 0 06:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:07 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')]} 06:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:07 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')]} 06:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:07 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:07 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 06:28:07 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 06:28:07 INFO - Using env: {'DISPLAY': ':0', 06:28:07 INFO - 'HOME': '/home/cltbld', 06:28:07 INFO - 'LANG': 'en_US.UTF-8', 06:28:07 INFO - 'LANGUAGE': 'en_US:en', 06:28:07 INFO - 'LOGNAME': 'cltbld', 06:28:07 INFO - 'MAIL': '/var/mail/cltbld', 06:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:07 INFO - 'MOZ_NO_REMOTE': '1', 06:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:07 INFO - 'NO_EM_RESTART': '1', 06:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:07 INFO - 'PWD': '/builds/slave/test', 06:28:07 INFO - 'SHELL': '/bin/bash', 06:28:07 INFO - 'SHLVL': '1', 06:28:07 INFO - 'TERM': 'linux', 06:28:07 INFO - 'TMOUT': '86400', 06:28:07 INFO - 'USER': 'cltbld', 06:28:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:07 INFO - '_': '/tools/buildbot/bin/python'} 06:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:08 INFO - Running setup.py (path:/tmp/pip-DWBMDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:08 INFO - Running setup.py (path:/tmp/pip-eHxIUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:08 INFO - Running setup.py (path:/tmp/pip-xqx0zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:08 INFO - Running setup.py (path:/tmp/pip-1ulXEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:08 INFO - Running setup.py (path:/tmp/pip-PiwH4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:08 INFO - Running setup.py (path:/tmp/pip-TaI_nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:08 INFO - Running setup.py (path:/tmp/pip-m9YvhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:08 INFO - Running setup.py (path:/tmp/pip-TjXzpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:08 INFO - Running setup.py (path:/tmp/pip-2CwZuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:08 INFO - Running setup.py (path:/tmp/pip-aseH3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:08 INFO - Running setup.py (path:/tmp/pip-tQSAVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:08 INFO - Running setup.py (path:/tmp/pip-dEQHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:08 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)) 06:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:08 INFO - Running setup.py (path:/tmp/pip-vvDTlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:09 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)) 06:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:09 INFO - Running setup.py (path:/tmp/pip-3QAgJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:09 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)) 06:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:09 INFO - Running setup.py (path:/tmp/pip-yTKuLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:09 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)) 06:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:09 INFO - Running setup.py (path:/tmp/pip-GzDkX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:09 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)) 06:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:09 INFO - Running setup.py (path:/tmp/pip-OV91U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:09 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)) 06:28:09 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)) 06:28:09 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)) 06:28:09 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)) 06:28:09 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)) 06:28:09 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)) 06:28:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:09 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 06:28:09 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 06:28:09 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 06:28:09 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 06:28:09 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 06:28:09 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 06:28:11 INFO - Downloading blessings-1.6.tar.gz 06:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:11 INFO - Installing collected packages: blessings 06:28:11 INFO - Running setup.py install for blessings 06:28:11 INFO - Successfully installed blessings 06:28:11 INFO - Cleaning up... 06:28:11 INFO - Return code: 0 06:28:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:11 INFO - Reading from file tmpfile_stdout 06:28:11 INFO - Current package versions: 06:28:11 INFO - argparse == 1.2.1 06:28:11 INFO - blessings == 1.6 06:28:11 INFO - blobuploader == 1.2.4 06:28:11 INFO - docopt == 0.6.1 06:28:11 INFO - manifestparser == 1.1 06:28:11 INFO - mozInstall == 1.12 06:28:11 INFO - mozcrash == 0.17 06:28:11 INFO - mozdebug == 0.1 06:28:11 INFO - mozdevice == 0.48 06:28:11 INFO - mozfile == 1.2 06:28:11 INFO - mozhttpd == 0.7 06:28:11 INFO - mozinfo == 0.9 06:28:11 INFO - mozleak == 0.1 06:28:11 INFO - mozlog == 3.1 06:28:11 INFO - moznetwork == 0.27 06:28:11 INFO - mozprocess == 0.22 06:28:11 INFO - mozprofile == 0.28 06:28:11 INFO - mozrunner == 6.11 06:28:11 INFO - mozscreenshot == 0.1 06:28:11 INFO - mozsystemmonitor == 0.0 06:28:11 INFO - moztest == 0.7 06:28:11 INFO - mozversion == 1.4 06:28:11 INFO - psutil == 3.1.1 06:28:11 INFO - requests == 1.2.3 06:28:11 INFO - wsgiref == 0.1.2 06:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:11 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')]} 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 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')]} 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:11 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 06:28:11 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 06:28:11 INFO - Using env: {'DISPLAY': ':0', 06:28:11 INFO - 'HOME': '/home/cltbld', 06:28:11 INFO - 'LANG': 'en_US.UTF-8', 06:28:11 INFO - 'LANGUAGE': 'en_US:en', 06:28:11 INFO - 'LOGNAME': 'cltbld', 06:28:11 INFO - 'MAIL': '/var/mail/cltbld', 06:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:11 INFO - 'MOZ_NO_REMOTE': '1', 06:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:11 INFO - 'NO_EM_RESTART': '1', 06:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:11 INFO - 'PWD': '/builds/slave/test', 06:28:11 INFO - 'SHELL': '/bin/bash', 06:28:11 INFO - 'SHLVL': '1', 06:28:11 INFO - 'TERM': 'linux', 06:28:11 INFO - 'TMOUT': '86400', 06:28:11 INFO - 'USER': 'cltbld', 06:28:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:11 INFO - '_': '/tools/buildbot/bin/python'} 06:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 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)) 06:28:11 INFO - Cleaning up... 06:28:11 INFO - Return code: 0 06:28:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:11 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')]} 06:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 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')]} 06:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:11 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:11 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 06:28:11 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 06:28:11 INFO - Using env: {'DISPLAY': ':0', 06:28:11 INFO - 'HOME': '/home/cltbld', 06:28:11 INFO - 'LANG': 'en_US.UTF-8', 06:28:11 INFO - 'LANGUAGE': 'en_US:en', 06:28:11 INFO - 'LOGNAME': 'cltbld', 06:28:11 INFO - 'MAIL': '/var/mail/cltbld', 06:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:11 INFO - 'MOZ_NO_REMOTE': '1', 06:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:11 INFO - 'NO_EM_RESTART': '1', 06:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:11 INFO - 'PWD': '/builds/slave/test', 06:28:11 INFO - 'SHELL': '/bin/bash', 06:28:11 INFO - 'SHLVL': '1', 06:28:11 INFO - 'TERM': 'linux', 06:28:11 INFO - 'TMOUT': '86400', 06:28:11 INFO - 'USER': 'cltbld', 06:28:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:11 INFO - '_': '/tools/buildbot/bin/python'} 06:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:12 INFO - Downloading/unpacking jsonschema 06:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:14 INFO - Downloading/unpacking functools32 (from jsonschema) 06:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:15 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:15 INFO - warning: no files found matching '*.txt' 06:28:15 INFO - no previously-included directories found matching 'build' 06:28:15 INFO - no previously-included directories found matching 'dist' 06:28:15 INFO - no previously-included directories found matching '.git*' 06:28:15 INFO - Installing collected packages: jsonschema, functools32 06:28:15 INFO - Running setup.py install for functools32 06:28:15 INFO - warning: no files found matching '*.txt' 06:28:15 INFO - no previously-included directories found matching 'build' 06:28:15 INFO - no previously-included directories found matching 'dist' 06:28:15 INFO - no previously-included directories found matching '.git*' 06:28:15 INFO - Successfully installed jsonschema functools32 06:28:15 INFO - Cleaning up... 06:28:15 INFO - Return code: 0 06:28:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:15 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 0x7fc143496f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24957d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, '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': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', '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 06:28:15 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 06:28:15 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 06:28:15 INFO - Using env: {'DISPLAY': ':0', 06:28:15 INFO - 'HOME': '/home/cltbld', 06:28:15 INFO - 'LANG': 'en_US.UTF-8', 06:28:15 INFO - 'LANGUAGE': 'en_US:en', 06:28:15 INFO - 'LOGNAME': 'cltbld', 06:28:15 INFO - 'MAIL': '/var/mail/cltbld', 06:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:15 INFO - 'MOZ_NO_REMOTE': '1', 06:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:15 INFO - 'NO_EM_RESTART': '1', 06:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:15 INFO - 'PWD': '/builds/slave/test', 06:28:15 INFO - 'SHELL': '/bin/bash', 06:28:15 INFO - 'SHLVL': '1', 06:28:15 INFO - 'TERM': 'linux', 06:28:15 INFO - 'TMOUT': '86400', 06:28:15 INFO - 'USER': 'cltbld', 06:28:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:15 INFO - '_': '/tools/buildbot/bin/python'} 06:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:15 INFO - Downloading/unpacking flake8 06:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:18 INFO - no previously-included directories found matching 'docs/_build' 06:28:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:18 INFO - Running setup.py install for pep8 06:28:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:18 INFO - no previously-included directories found matching 'docs/_build' 06:28:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:18 INFO - Cleaning up... 06:28:18 INFO - Return code: 0 06:28:18 INFO - Running post-action listener: _resource_record_post_action 06:28:18 INFO - Running post-action listener: _start_resource_monitoring 06:28:18 INFO - Starting resource monitoring. 06:28:18 INFO - ##### 06:28:18 INFO - ##### Running install step. 06:28:18 INFO - ##### 06:28:18 INFO - Running pre-action listener: _resource_record_pre_action 06:28:18 INFO - Running main action method: install 06:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:18 INFO - Reading from file tmpfile_stdout 06:28:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:18 INFO - Reading from file tmpfile_stdout 06:28:18 INFO - Output received: 06:28:18 INFO - Usage: mozinstall [options] installer 06:28:18 INFO - Options: 06:28:18 INFO - -h, --help show this help message and exit 06:28:18 INFO - -d DEST, --destination=DEST 06:28:18 INFO - Directory to install application into. [default: 06:28:18 INFO - "/builds/slave/test"] 06:28:18 INFO - --app=APP Application being installed. [default: firefox] 06:28:18 INFO - mkdir: /builds/slave/test/build/application 06:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:28:34 INFO - Reading from file tmpfile_stdout 06:28:34 INFO - Output received: 06:28:34 INFO - /builds/slave/test/build/application/firefox/firefox 06:28:34 INFO - Running post-action listener: _resource_record_post_action 06:28:34 INFO - ##### 06:28:34 INFO - ##### Running run-tests step. 06:28:34 INFO - ##### 06:28:34 INFO - Running pre-action listener: _resource_record_pre_action 06:28:34 INFO - Running main action method: run_tests 06:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:34 INFO - Python 2.7.3 06:28:34 INFO - Return code: 0 06:28:34 INFO - grabbing minidump binary from tooltool 06:28:34 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')]} 06:28:34 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 0x2524640>, '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 0x2525540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25259d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:34 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 06:28:34 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 06:28:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:34 INFO - Return code: 0 06:28:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:28:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:28:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:35 INFO - Return code: 0 06:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 06:28:35 INFO - Using env: {'DISPLAY': ':0', 06:28:35 INFO - 'HOME': '/home/cltbld', 06:28:35 INFO - 'LANG': 'en_US.UTF-8', 06:28:35 INFO - 'LANGUAGE': 'en_US:en', 06:28:35 INFO - 'LOGNAME': 'cltbld', 06:28:35 INFO - 'MAIL': '/var/mail/cltbld', 06:28:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:35 INFO - 'MOZ_NO_REMOTE': '1', 06:28:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:35 INFO - 'NO_EM_RESTART': '1', 06:28:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:35 INFO - 'PWD': '/builds/slave/test', 06:28:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:35 INFO - 'SHELL': '/bin/bash', 06:28:35 INFO - 'SHLVL': '1', 06:28:35 INFO - 'TERM': 'linux', 06:28:35 INFO - 'TMOUT': '86400', 06:28:35 INFO - 'USER': 'cltbld', 06:28:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461331653.94268-819205457', 06:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:35 INFO - '_': '/tools/buildbot/bin/python'} 06:28:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:28:35 INFO - mozversion application_buildid: 20160419211331 06:28:35 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:28:35 INFO - mozversion application_display_name: Nightly 06:28:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:35 INFO - mozversion application_name: Firefox 06:28:35 INFO - mozversion application_remotingname: firefox 06:28:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:28:35 INFO - mozversion application_vendor: Mozilla 06:28:35 INFO - mozversion application_version: 48.0a1 06:28:35 INFO - mozversion platform_buildid: 20160419211331 06:28:35 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:28:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:28:35 INFO - mozversion platform_version: 48.0a1 06:28:35 INFO - using testdate: 1461331715 06:28:35 INFO - actual date: 1461331715 06:28:35 INFO - starting webserver on 'localhost:51489' 06:28:35 INFO - SUITE-START | Running 2 tests 06:28:35 INFO - TEST-START | dromaeo_css 06:28:35 INFO - operating with platform_type : linux_ 06:28:35 INFO - Initialising browser for dromaeo_css test... 06:28:35 INFO - TEST-INFO | started process 8375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfdkRF/profile http://localhost:51489/getInfo.html) 06:28:40 INFO - PROCESS | 8375 | __metrics Screen width/height:1600/1200 06:28:40 INFO - PROCESS | 8375 | colorDepth:24 06:28:40 INFO - PROCESS | 8375 | Browser inner width/height: 1024/697 06:28:40 INFO - PROCESS | 8375 | __metrics 06:28:41 ERROR - PROCESS | 8375 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:28:42 INFO - TEST-INFO | 8375: exit 0 06:28:42 INFO - Browser initialized. 06:28:42 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:42 INFO - TEST-INFO | started process 8454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfdkRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:54 INFO - PROCESS | 8454 | RSS: Main: 154865664 06:28:54 INFO - PROCESS | 8454 | 06:29:45 INFO - PROCESS | 8454 | 1461331785418 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] 06:31:57 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51489/tests/dromaeo/cssquery-ext.html) 06:31:58 INFO - PROCESS | 8454 | RSS: Main: 241233920 06:31:58 INFO - PROCESS | 8454 | 06:35:00 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-ext.html (next: http://localhost:51489/tests/dromaeo/cssquery-jquery.html) 06:35:01 INFO - PROCESS | 8454 | RSS: Main: 238137344 06:35:01 INFO - PROCESS | 8454 | 06:38:03 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51489/tests/dromaeo/cssquery-mootools.html) 06:38:04 INFO - PROCESS | 8454 | RSS: Main: 244596736 06:38:04 INFO - PROCESS | 8454 | 06:41:06 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51489/tests/dromaeo/cssquery-prototype.html) 06:41:06 INFO - PROCESS | 8454 | RSS: Main: 242466816 06:41:06 INFO - PROCESS | 8454 | 06:44:09 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51489/tests/dromaeo/cssquery-yui.html) 06:44:10 INFO - PROCESS | 8454 | RSS: Main: 210575360 06:44:10 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-yui.html (next: http://localhost:51489/tests/dromaeo/cssquery-dojo.html) 06:47:13 INFO - PROCESS | 8454 | RSS: Main: 293761024 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | __start_tp_report 06:47:13 INFO - PROCESS | 8454 | _x_x_mozilla_page_load 06:47:13 INFO - PROCESS | 8454 | _x_x_mozilla_page_load_details 06:47:13 INFO - PROCESS | 8454 | |i|pagename|runs| 06:47:13 INFO - PROCESS | 8454 | |0;dojo.html;2571.7428257174283;2655.8539280339596;2660.3881107345296;2675.3579141006157;2675.9197224083273;4409.316555933828;4495.617872480843;4556.31655251712;4562.63498920086;4562.817487300508;4551.294549344857;4553.134904368168;4644.7677616119145;4666.066786642668;4680.555347242015;4196.181744559812;4224.134052519242;4243.809028593705;4301.698881078326;4385.320275357309;4350.608445239928;4363.80362883671;4367.323064924942;4393.428854248959;4400.075984043355;4124.649404800595;4196.391523229146;4208.621224089816;4299.1831552005015;4302.720323178999;4205.663546916239;4241.427407300037;4244.087521182961;4296.699231053827;4306.332518459643;4237.300845360512;4254.936175957332;4256.106217694288;4277.294246449332;4296.63478604319;4346.217680817484;4407.427034485529;4469.843555475542;4496.100779844044;4551.499335073139;4875.219964805649;4875.829345972909;4882.3408839806525;4892.168331383637;4939.703617782909;4896.143174944371;4905.4358748744;4906.31311616374;4940.752962351868;4945.381827271591;4479.216137175981;4551.45382554089;4597.126545956257;4623.606993405531;4635.860924172281;4954.826581069645;4975.676581022222;4983.426905905795;4988;5019.071471777733;4788.904221915612;4791.616670666338;4795.112904112751;4797.56821886032;4833.613310935187;4736.834210802605;4866.513348665105;4905.901881962341;5000.62495312853;5003.5997120230295;4877.975610121926;4895.975520122377;4906.386701662293;4906.460289368167;4952.5542701157065;4889.926651100236;4890.217565189552;4897.715691879424;4900.215965445583;4947.1837146871085;4015.2371049500503;4046.2716710991717;4050.23045621331;4056.9188616228103;4081.8571350002608;3622.5471816022996;3628.38317486028;3643.143861192618;3644.835982380799;3645.690116340141;4103.4870641169855;4205.9789701051295;4214.683898707609;4256.1487702459635;4262.381954616563;4862.197737373364;4917.606591472673;4919.0899683558655;4924.113659541245;4971.229459433794;4159.188958153191;4214.388913607571;4240.512341080754;4247.532771395144;4289.82840686369;4380.4305440292555;4444.688871778944;4463.977680111643;4474.440694913136;4477.059817438309;4644.8374306899095;4667.089917466129;4669.859904202879;4670;4719.032598317337;4748.9050218994735;4917.950820491749;4919.311296418576;4925.088858561177;4970.726610036338;4632.930506042345;4675.111728771522;4683.461401938821;4716.0332131913565;4726.432828060655;4764.190087685032;4780.426348838162;4793.664443488922;4794.232922732485;4838.395200599925;4687.39063921688;4840.7337596431125;4845.854624361275;4865.878353041202;4902.313676085422;4751.239801631722;4778.450478195052;4783.545563171493;4804.711717296974;4823.855284341475;4763.523647635208;4765.451973023008;4769.523047695203;4773.427188737235;4818.253170758538;4565.406497155349;4664.580187783115;4664.930026049544;4742.407199100113;4758.191107511662;4742.051589682146;4772.236442169376;4779.737114458738;4822.662413631152;4824.638152138674;4684.391029166187;4691.108689349013;4695.624350052056;4745.359376484269;4754.904901902012 06:47:13 INFO - PROCESS | 8454 | |1;ext.html;587.1310460518432;600.6936462404174;617.02510034146;632.0140580694116;642.5534253693685;27666.585001224972;28402.43195136096;34306.313873722545;34697.826510867475;35703.28593428136;37506.437403438904;38257;38279.808600957025;38307.425388619195;38341.616583834155;7612.69549218032;7786.961065194666;7791.883121753178;7793.844123117534;7794.532328060306;7281.635918204095;9615.903840961571;10076.445795481246;10078.596856125747;10083.44541050242;9804.558794854212;9913.256505762061;9921;9924.05721456464;9934.205263578897;9599.184069354078;9723.562439690195;9728.124468797841;9730.12428881404;9739.707808765748;9668.081532254424;9777.46223957682;9782.755431114208;9782.902170978341;9786.461744604045;34959.30081398358;38001;38044;38098.23803523942;38146.809265953496;3165.287283144998;3174.5873036505336;3186.6494685584566;3196.4566023776015;3197.9200519986953;29293.414131717458;29314.70685293141;29717;29844.55233171504;30972.380552388826;3182.5067114597273;3198.072558957899;3213.983930080358;3246.870125194989;3282.5404443377947;234127;234932;235515;235730;236480;54805.72597137069;55189.72405138029;55335.446645533026;55342.72328638411;55372.44627553673;59330.70334648385;59577;59591.10613340804;59621.10568341478;59679.70160149172;13842.169469831842;14227.78658320126;14244.501442449464;14246.928765356313;14307.78538321926;9008.054154313833;10527.315724477885;10539.736506587396;10585.259031867849;10851.51168197433;17087.401940932006;17212.913935430493;17237.741433878502;17264.74102888458;17273.222704978056;5876.970615146983;5960.910586341209;6038.396160383926;6057.42454466825;6119.173911521976;939.7650587353162;988.7874107067015;1011.8178727829062;1031.0668844695563;1034.1519953638094;27826.860865695948;28062.43875122486;28500.85749571239;28656.283592909927;28716.856415718205;1029.5418538750334;1038.5638032026416;1040.8230600797883;1082.3235477826358;1120.910327173824;14890.851091488947;15218.771718424012;15254.161021143722;15551.766723499157;15552.688946221013;332288;336527;337877;339604;339791;48866;49596.75201623969;49597.50402496001;49670;49825.50174498281;1058.724731569782;1078.8921107889148;1255.2217625072512;1268.9175203611735;1349.3455673998103;24512.75487245105;25306.240812775646;25838.61242081408;25945.870270648527;25971.87014064993;35101.64898350984;35260.29479410346;35405.468917965736;35489.64510354863;35562.64437355697;184552;184792;185115;185528;185914;32014;33203.50194747032;38998;39530.81407557778;39850.20299593934;39195;40259.1948161041;40290.395644065946;40390.79804600958;40525.1894962105;33512.49731253985;33984.9022646605;34109.317813644084;34176.31647366989;34545.48181777326;33271;33455.832720837214;33866;34104.829475853454;34138.65861341355;33777;33833.15417114592;34160.82919585386;34649.133771655914;34864.30271394608;29866.253343666584;30622;30868.53697194499;31044.22389440282;31073.68926310708;23683.763162368847;24227.198034093635;24429.877850610632;24486.87756561206;24552.631710523998 06:47:13 INFO - PROCESS | 8454 | |2;jquery.html;378.6573151298076;380.885734279716;388.8716723481252;389.0875896023824;389.7661403158104;15691.136987465685;16366.509004729847;16783.664326713457;16794.580135496617;16806.915965420172;15347.386104555804;16350.264238109285;16638.750418743697;16649.084300363476;16654.16729163543;4897.755112244383;5163.948360516403;5186.4813518648025;5189.558887494549;5203.401608814978;3671.706263498927;3925.1757131002523;5514.476124768141;5905.616134951236;5907.4683278505145;5757.712114394284;5856.941430585683;5876.382979787125;5879.559033072515;5883.941160588403;5680.346760122577;5701.458361455655;5723.198752174678;5724.656520608777;5842.240508733858;3358.395488812013;4852.611791056743;5193.8961220775755;5203.16749320107;5204.219367094928;19039.238430462763;19446.027698615013;19459.513512162168;20715.5856882863;20785;1902.771667399907;2057.809916532195;2342.4495243617735;2452.730199678034;2565.0381107084845;12920.547780827626;13217.140885842486;13265.403056862368;13626.386812593457;13703.862961370358;1711.9441796393503;1745.24954269664;1749.457668122886;1773.733939909024;1785.8392744652913;67588;67663.66168169127;68114.65942670305;68664.3133568668;69455;9441.811163776685;9530.428174309563;9544.570494327772;9814.607415703435;9819.214462842956;13461.86538134606;13595.728085438433;13601.795973060413;13615.25116118623;13627.454901804014;7008.299170082951;7069.116360454943;7121.92878071223;7160.10498687664;7270.091238595176;6708.563943343667;6732.663366831639;6761.22245941723;6842.93157068423;6887.449004079662;6082.928121298716;6119.143319935212;6146.508279337642;6153.1693221415435;6185.103160041859;1640.4996476074673;1641.5813967438228;1740.4430582213822;1741.8171092035407;1784.4289827255413;895.7984453498041;942.236788201559;957.368137029571;969.8787651543557;1019.6940917724801;15693.686126277638;15908.204589770465;16623.6675266494;17003.74494382585;17497.092763216737;881.5592203898051;906.664534122379;929.1359036096495;941.2046820436857;957.674390707149;5634.7182640867795;5704.3154821421695;9554.856677149848;9964.20286377088;10116.190704743603;281686;284465;284629;285796;285888;78772.60613696894;80581.59709201417;82090.58954705189;82883;82957;458.8852786803299;461.35640781110163;461.38405229019634;462.4173541337938;467.14512442230637;9477.668281610111;9869.605215791287;10179.847302290324;10322.638707645196;10532.736681582715;25888.611670824575;27690;28132.296692582848;31540.36919261648;34547.136321591155;44800.55199447964;45527.31709024434;49426.75286623544;49978.500214998836;49998.750006249735;7532.585707786125;7555.639984802789;7571.772846814604;7774.2614451627005;7926.256223630792;5904.852378690567;10979.937423153484;11781.293122412682;12284;12637.810432843698;10778.892211078102;10813.729656758644;10881.945590271998;10909.399983000694;10920.617778377718;10562.947185264025;10603.257771955889;10696.304740191863;10773.407462589634;10825.837612435662;10402.791944161227;10730.946345268223;10909.236353455182;10915.39965301916;11080.833787493355;7803.804904877424;7822.882656760039;7997.480163789568;8201.548914809742;8316.085230624747;9314.573920978222;10683.94658026705;10719.035286824223;10755;10818.67543973682 06:47:13 INFO - PROCESS | 8454 | |3;mootools.html;1282.7434513097382;1433.1114708880496;1470.9558713238603;1611.2024547848816;1814.7912990006146;6861.931380686192;7594.354479869211;7808.336291415222;7811.06267247931;7828.021497312836;7550.546967181973;7692.4615276930635;7701.345385642213;7716.305532502074;7728.65221065052;1848.3438379375264;2169.5443956769095;2205.151016858505;2229.2532001779423;2235.1394713035515;2203.746569144545;2222.4554984028937;2226.309843948373;2227.0201111510883;2229.9554008919813;2165.415337858777;2225.4881377283236;2226.677131815886;2228.832837537183;2229.476073122823;1864.5431869192066;2165.826733861295;2238.6194346961056;2243.6634504824406;2248.15694114707;2140.9357719268446;2156.3746513511064;2162.048698572623;2162.37291185556;2187.57342318248;7823.452358334919;7844.37245020397;7849.45053846231;7905.644246008944;7907.881381779278;4471.0610771737975;4640.559146881041;4643.86068417948;4652.4184476940045;4694.718316900997;3012.4426981008364;3041.6654168041496;3086.35186610812;3098.8915387961315;3137.5293705944064;962.6486332488661;972.4554249620236;986.1716158426884;989.7228775942675;997.760537471009;10956.233063685624;10963;10963.397013164273;10974.286671366335;11012.779744405147;4263.253930562139;4335.588119128678;4423.579759922803;4441.0673758511075;4446.755428451402;9325;9346.439213647067;9359.532023398802;9382.202512786353;9387.953060234655;4185.351270553069;4672.159011377917;4684.812607495662;4691.81232750693;4702.224133018082;4259.680523960654;4370.0604370059955;4370.322599997005;4391.385206071152;4411.558844115562;3748.55017397914;3771.773693578394;3835.520559930009;3879.1465877506903;3881.0879443330796;1256.340421278836;1276.4128500889694;1283.3519072868328;1283.6020833541631;1285.7107150890974;726.077881091022;809.7368355284556;887.1572006593761;907.7367563406539;909.9044600317004;5185.325907631984;5290.127129023668;5337.733113344318;5360.276362690986;5404.351477822686;835.4402550291319;853.7108965462197;868.3574155125162;898.3531857062904;947.8767760191131;3619.149499867529;3673.669369756681;3694.3350196964266;3694.8891533254045;3734.8506059757847;9575.664851730156;9910.752231194278;10058.49707514636;10093.293469457214;10108.292419530562;9934.304598678023;9963.601455941825;9967.80064398708;9976.301658883953;9981.201503879673;7027.297270273034;7070.363667269868;7140.285971402818;7231.819204519929;7239.239879812649;5213.061648903234;5231.581473482189;5237.973810130925;5653.293338332708;5695.914561281501;8826.161514656098;8969.282457403522;9003.54982250898;9077.137671921157;9080.091990800867;8711;9262.53687315645;9333.579988900652;9496.287778416508;9528.761780955254;5974.61165024272;6152.446279834837;6159.81520554384;6933.826654333682;7031.367176954099;6474.093626892333;6584.242812076481;7214.927850721426;7253.963730181315;7307.817304567428;6677.666116694243;6842.178938527409;6865.691043902936;6923.273056329013;6955.269696681776;6582.967085164543;6636.535442519171;6642.667866606554;6726.260111387841;6766.627835469097;6072.78745243932;6130.141780150693;6189.442950134509;6194.938050619436;6198.783042593487;4844.515548445127;4850.757462126809;4886.706797592155;4956.8760780980765;4988.401391833003;4801.831935882367;4820.325154478306;4851.927221091757;4894.045661096052;4942.4810394909455 06:47:13 INFO - PROCESS | 8454 | |4;prototype.html;316.71337439617156;318.8469534623381;319.4361951156208;319.6867070271134;324.3642460776877;4905.877353066175;4974.65177437579;4982.750862456881;4990.800367985285;5000;4901.926471102927;4909.386326709161;4922.950770492294;4925.901481970367;4942.431620363659;3667.651573100551;3740.8129593520353;3853.2678791029753;3857.688385948777;3914.8825535233846;3870.4581358609817;3877.4490203918376;3896.08442016126;3902.2585708715255;3917.099067214542;3647.1246900743895;3858.9195025392937;3861.826217820191;3871.690264778811;3878.1080351519167;3793.089658481972;3893.6761501089763;3922.195949830278;3932.5870783567884;3933.2723446162267;3470.236547959445;3486.860525578974;3486.860525578974;3487.459443786217;3494.7204223662047;4709.1288111699105;4728.858134255978;4733.266343716729;4733.692309999839;4737.502562230985;4311.525732169459;4466.55334466554;4469.01128997593;4492.775361231958;4496.2581174106235;5158.380994280673;5171.172612382001;5186.559142472895;5197.246399272084;5201.55786758126;3805.219929914361;3810.333191691471;3812.3519001769764;3814.771113733185;3819.3888977763704;5242;5412.675239485604;5421.2952316199035;5442.346918369782;5446.346438427414;3852.1910398816563;3868.3423817951016;3880.1075752577067;3891.2412079644764;3891.5330160380367;3930.587288334741;3934.11482416454;3947.9013024674036;3953.584873588232;3958.7030972677167;4352.337750896874;4441.267905516851;4455.1980643484485;4459.821607135678;4473.463184417826;5160.638755287094;5183.50756678115;5185.948140518622;5197.116490196676;5206.947930520646;1333.5399287245884;1373.478078330228;1378.4968486502355;1383.4950243161175;1383.9584812455641;851.284920666643;936.7939053408239;950.2682934140673;956.8469044952774;965.7006328038331;4511.390962220124;4515.616172625298;4522.796474158671;4525.366448697185;4530.207213737583;5292.179712144623;5296.867578310496;5297.3643162819935;5300.363956325188;5309.46905309466;4415.867523974286;4508.549145085531;4518.864434066983;4530.22986092365;4535.818567257273;2826.9293267668063;2827.3638431353193;2839.48889199946;2846.694177716015;2849.059810262608;4924.581410580141;4951.455339912607;4986.202207646759;5041.168207245837;5045.445001049881;5201.479852014768;5396.244525766396;5400.83797486076;5415.160650099241;5418.593605479605;4968.552830245295;5013.699178049329;5031.320771695848;5052.873678158076;5059.2916991621205;5253;5264.73676316175;5268.130758424817;5274.657147285414;5277.762500687555;5026.723530205728;5149.7682604282145;5159.277701121771;5170.146925757208;5176.585873130065;4990.176620857518;4998.87502812418;5006.1739812930455;5007.3240112584335;5016.620429381949;3875.2055828554517;3875.321818681663;3878.26313000529;3881.902952426212;3899.863504777319;5105.5149760772665;5219.817306394258;5236.581073514186;5260.421353651019;5272.156454967187;5045.8738531537;5054.595632349477;5060.987802439453;5073.8731531712;5086.64393492452;5066.341375621146;5071.797128114982;5094.974525127351;5095.592352611856;5107.157319042465;4795.736234507136;5002.474740152232;5109.46350633193;5116.079105760999;5130.230465430215;4974.850754477371;5059.898802023865;5146.305248791366;5224.164133738584;5225.216217567396;5102.69383836971;5128.256402821496;5133.10170720115;5137.563307118788;5154.098032844162 06:47:13 INFO - PROCESS | 8454 | |5;yui.html;611.636076534462;637.7927173668558;678.9781379024573;685.479035932691;705.3193668110275;11529.769404611914;11892;11921;11940.582079627215;11964.700882477942;11314.943425282883;11361.091112710963;11369.09047276218;11370.204085714004;11432;637.894747366684;776.2819392062348;789.4631650477672;813.1177672225642;813.3574476163824;808.3613944983456;814.2020819596798;814.2183503836295;814.3363159025405;814.5642081486405;850.6002178975872;863.1886027134505;864.4640322999749;865.8225063861893;865.8398196333699;669.3674477618653;833.0503226321937;854.7179430787825;859.8624220124781;859.9981022109235;630.93690630937;631.6368088349171;631.9684015799191;632.0708558419117;632.2918331468738;11657.417129143509;11771.411429428494;11789.05687545003;11859.584914528037;11869.46587403569;11718.589849355232;12198.10929305959;12396;12556.309402982832;12733.936330318382;8893.28853691703;8939.955300223522;8983.685571004984;9018.774530636721;9036.728898133066;3954.307996100671;4053.4122552230056;4123.958760412387;4128.710990230685;4129.29801933669;44779;45231.09537809291;45549;45596.772016140036;45612.77193614044;9200.401973871676;9695.951520242354;9822.508874556386;9829.606815727433;9995.650152244636;16844.157792110345;16867.578310542336;16872.818902676696;16889.071101089314;17070.23183956725;5889.970550147222;5907.616004959664;5925.4370834770625;5933;6152.753889844445;3250.6099268087983;3336.6162891267813;3344.916377090592;3380.983095084509;3393.6267010628812;2712.145674112648;2784.1647505748197;2794.385235248242;2803.9158825235277;2805.719428057219;424.9043965107826;497.1846172277468;502.24913753938097;505.2068252843001;512.101262284688;425.28552032584935;505.9443461219263;540.0899484368773;546.472653888999;558.187836697604;7156.642167891689;7233.89149162763;7537.886931696029;7571.697132114764;7664.578448185403;535.4404647143745;538.2598926476095;541.9485148910848;548.3200830969569;551.5863102672995;3416.9145771355916;3533.3286675531567;3550.786952782841;3578.6779189873037;3694.7228957827733;56840.147397789064;56958.71520642453;56984.43015569874;57111.428885711444;57477.42522574804;49008.75495622499;49344.25983610249;49694.25458618124;50457;50653.74673126611;45732.542674573495;46234.537654623025;46573;46631.533684663395;47239;6949.861002779815;7003.159620845531;7105.680244388912;7115.82210444743;7156;30420.543691844196;30453.086407407813;30531.54202686917;30969.380612388075;31134;39835.20329593334;41168.588314116474;41534.58465415307;41897.162056759305;42108.57891421169;9521.523923803921;9613.51932403363;9798.216142708423;9900.257480688833;9907.504624768588;10723.839142413026;10840.620578279722;11049;11262.155338349492;11457.427128643702;8966.282697384064;10902.236843420884;10967.616133435291;11064.778704425706;11066.059384952368;9416.152546270869;9605.567749451431;9768.706938791847;9844;10025.5488503019;11066.446677666245;11259.437028148395;11410.14423918193;11549.826752598885;11814.94092529532;8971.551422428984;9262.120098590623;9431.764205894908;9530.523473826419;9674.177694896012;8723.214910658071;8876.556172191495;8916.885389326335;9028.322875784212;9049.77375565616 06:47:13 INFO - PROCESS | 8454 | __end_tp_report 06:47:13 INFO - PROCESS | 8454 | __start_cc_report 06:47:13 INFO - PROCESS | 8454 | _x_x_mozilla_cycle_collect,939 06:47:13 INFO - PROCESS | 8454 | __end_cc_report 06:47:13 INFO - PROCESS | 8454 | __startTimestamp1461332833419__endTimestamp 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | ------- Summary: start ------- 06:47:13 INFO - PROCESS | 8454 | Number of tests: 6 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#0] dojo.html Cycles:165 Average:4534.69 Median:4675.11 stddev:458.95 (9.8%) stddev-sans-first:433.76 06:47:13 INFO - PROCESS | 8454 | Values: 2571.7 2655.9 2660.4 2675.4 2675.9 4409.3 4495.6 4556.3 4562.6 4562.8 4551.3 4553.1 4644.8 4666.1 4680.6 4196.2 4224.1 4243.8 4301.7 4385.3 4350.6 4363.8 4367.3 4393.4 4400.1 4124.6 4196.4 4208.6 4299.2 4302.7 4205.7 4241.4 4244.1 4296.7 4306.3 4237.3 4254.9 4256.1 4277.3 4296.6 4346.2 4407.4 4469.8 4496.1 4551.5 4875.2 4875.8 4882.3 4892.2 4939.7 4896.1 4905.4 4906.3 4940.8 4945.4 4479.2 4551.5 4597.1 4623.6 4635.9 4954.8 4975.7 4983.4 4988.0 5019.1 4788.9 4791.6 4795.1 4797.6 4833.6 4736.8 4866.5 4905.9 5000.6 5003.6 4878.0 4896.0 4906.4 4906.5 4952.6 4889.9 4890.2 4897.7 4900.2 4947.2 4015.2 4046.3 4050.2 4056.9 4081.9 3622.5 3628.4 3643.1 3644.8 3645.7 4103.5 4206.0 4214.7 4256.1 4262.4 4862.2 4917.6 4919.1 4924.1 4971.2 4159.2 4214.4 4240.5 4247.5 4289.8 4380.4 4444.7 4464.0 4474.4 4477.1 4644.8 4667.1 4669.9 4670.0 4719.0 4748.9 4918.0 4919.3 4925.1 4970.7 4632.9 4675.1 4683.5 4716.0 4726.4 4764.2 4780.4 4793.7 4794.2 4838.4 4687.4 4840.7 4845.9 4865.9 4902.3 4751.2 4778.5 4783.5 4804.7 4823.9 4763.5 4765.5 4769.5 4773.4 4818.3 4565.4 4664.6 4664.9 4742.4 4758.2 4742.1 4772.2 4779.7 4822.7 4824.6 4684.4 4691.1 4695.6 4745.4 4754.9 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#1] ext.html Cycles:180 Average:41738.42 Median:185855.08 stddev:68208.00 (36.7%) stddev-sans-first:68329.36 06:47:13 INFO - PROCESS | 8454 | Values: 587.1 600.7 617.0 632.0 642.6 27666.6 28402.4 34306.3 34697.8 35703.3 37506.4 38257.0 38279.8 38307.4 38341.6 7612.7 7787.0 7791.9 7793.8 7794.5 7281.6 9615.9 10076.4 10078.6 10083.4 9804.6 9913.3 9921.0 9924.1 9934.2 9599.2 9723.6 9728.1 9730.1 9739.7 9668.1 9777.5 9782.8 9782.9 9786.5 34959.3 38001.0 38044.0 38098.2 38146.8 3165.3 3174.6 3186.6 3196.5 3197.9 29293.4 29314.7 29717.0 29844.6 30972.4 3182.5 3198.1 3214.0 3246.9 3282.5 234127.0 234932.0 235515.0 235730.0 236480.0 54805.7 55189.7 55335.4 55342.7 55372.4 59330.7 59577.0 59591.1 59621.1 59679.7 13842.2 14227.8 14244.5 14246.9 14307.8 9008.1 10527.3 10539.7 10585.3 10851.5 17087.4 17212.9 17237.7 17264.7 17273.2 5877.0 5960.9 6038.4 6057.4 6119.2 939.8 988.8 1011.8 1031.1 1034.2 27826.9 28062.4 28500.9 28656.3 28716.9 1029.5 1038.6 1040.8 1082.3 1120.9 14890.9 15218.8 15254.2 15551.8 15552.7 332288.0 336527.0 337877.0 339604.0 339791.0 48866.0 49596.8 49597.5 49670.0 49825.5 1058.7 1078.9 1255.2 1268.9 1349.3 24512.8 25306.2 25838.6 25945.9 25971.9 35101.6 35260.3 35405.5 35489.6 35562.6 184552.0 184792.0 185115.0 185528.0 185914.0 32014.0 33203.5 38998.0 39530.8 39850.2 39195.0 40259.2 40290.4 40390.8 40525.2 33512.5 33984.9 34109.3 34176.3 34545.5 33271.0 33455.8 33866.0 34104.8 34138.7 33777.0 33833.2 34160.8 34649.1 34864.3 29866.3 30622.0 30868.5 31044.2 31073.7 23683.8 24227.2 24429.9 24486.9 24552.6 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#2] jquery.html Cycles:180 Average:21112.10 Median:24362.86 stddev:47921.59 (196.7%) stddev-sans-first:48030.74 06:47:13 INFO - PROCESS | 8454 | Values: 378.7 380.9 388.9 389.1 389.8 15691.1 16366.5 16783.7 16794.6 16806.9 15347.4 16350.3 16638.8 16649.1 16654.2 4897.8 5163.9 5186.5 5189.6 5203.4 3671.7 3925.2 5514.5 5905.6 5907.5 5757.7 5856.9 5876.4 5879.6 5883.9 5680.3 5701.5 5723.2 5724.7 5842.2 3358.4 4852.6 5193.9 5203.2 5204.2 19039.2 19446.0 19459.5 20715.6 20785.0 1902.8 2057.8 2342.4 2452.7 2565.0 12920.5 13217.1 13265.4 13626.4 13703.9 1711.9 1745.2 1749.5 1773.7 1785.8 67588.0 67663.7 68114.7 68664.3 69455.0 9441.8 9530.4 9544.6 9814.6 9819.2 13461.9 13595.7 13601.8 13615.3 13627.5 7008.3 7069.1 7121.9 7160.1 7270.1 6708.6 6732.7 6761.2 6842.9 6887.4 6082.9 6119.1 6146.5 6153.2 6185.1 1640.5 1641.6 1740.4 1741.8 1784.4 895.8 942.2 957.4 969.9 1019.7 15693.7 15908.2 16623.7 17003.7 17497.1 881.6 906.7 929.1 941.2 957.7 5634.7 5704.3 9554.9 9964.2 10116.2 281686.0 284465.0 284629.0 285796.0 285888.0 78772.6 80581.6 82090.6 82883.0 82957.0 458.9 461.4 461.4 462.4 467.1 9477.7 9869.6 10179.8 10322.6 10532.7 25888.6 27690.0 28132.3 31540.4 34547.1 44800.6 45527.3 49426.8 49978.5 49998.8 7532.6 7555.6 7571.8 7774.3 7926.3 5904.9 10979.9 11781.3 12284.0 12637.8 10778.9 10813.7 10881.9 10909.4 10920.6 10562.9 10603.3 10696.3 10773.4 10825.8 10402.8 10730.9 10909.2 10915.4 11080.8 7803.8 7822.9 7997.5 8201.5 8316.1 9314.6 10683.9 10719.0 10755.0 10818.7 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#3] mootools.html Cycles:180 Average:5202.54 Median:5234.78 stddev:2903.74 (55.5%) stddev-sans-first:2896.95 06:47:13 INFO - PROCESS | 8454 | Values: 1282.7 1433.1 1471.0 1611.2 1814.8 6861.9 7594.4 7808.3 7811.1 7828.0 7550.5 7692.5 7701.3 7716.3 7728.7 1848.3 2169.5 2205.2 2229.3 2235.1 2203.7 2222.5 2226.3 2227.0 2230.0 2165.4 2225.5 2226.7 2228.8 2229.5 1864.5 2165.8 2238.6 2243.7 2248.2 2140.9 2156.4 2162.0 2162.4 2187.6 7823.5 7844.4 7849.5 7905.6 7907.9 4471.1 4640.6 4643.9 4652.4 4694.7 3012.4 3041.7 3086.4 3098.9 3137.5 962.6 972.5 986.2 989.7 997.8 10956.2 10963.0 10963.4 10974.3 11012.8 4263.3 4335.6 4423.6 4441.1 4446.8 9325.0 9346.4 9359.5 9382.2 9388.0 4185.4 4672.2 4684.8 4691.8 4702.2 4259.7 4370.1 4370.3 4391.4 4411.6 3748.6 3771.8 3835.5 3879.1 3881.1 1256.3 1276.4 1283.4 1283.6 1285.7 726.1 809.7 887.2 907.7 909.9 5185.3 5290.1 5337.7 5360.3 5404.4 835.4 853.7 868.4 898.4 947.9 3619.1 3673.7 3694.3 3694.9 3734.9 9575.7 9910.8 10058.5 10093.3 10108.3 9934.3 9963.6 9967.8 9976.3 9981.2 7027.3 7070.4 7140.3 7231.8 7239.2 5213.1 5231.6 5238.0 5653.3 5695.9 8826.2 8969.3 9003.5 9077.1 9080.1 8711.0 9262.5 9333.6 9496.3 9528.8 5974.6 6152.4 6159.8 6933.8 7031.4 6474.1 6584.2 7214.9 7254.0 7307.8 6677.7 6842.2 6865.7 6923.3 6955.3 6583.0 6636.5 6642.7 6726.3 6766.6 6072.8 6130.1 6189.4 6194.9 6198.8 4844.5 4850.8 4886.7 4956.9 4988.4 4801.8 4820.3 4851.9 4894.0 4942.5 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#4] prototype.html Cycles:180 Average:4303.23 Median:4925.24 stddev:1220.17 (24.8%) stddev-sans-first:1186.34 06:47:13 INFO - PROCESS | 8454 | Values: 316.7 318.8 319.4 319.7 324.4 4905.9 4974.7 4982.8 4990.8 5000.0 4901.9 4909.4 4923.0 4925.9 4942.4 3667.7 3740.8 3853.3 3857.7 3914.9 3870.5 3877.4 3896.1 3902.3 3917.1 3647.1 3858.9 3861.8 3871.7 3878.1 3793.1 3893.7 3922.2 3932.6 3933.3 3470.2 3486.9 3486.9 3487.5 3494.7 4709.1 4728.9 4733.3 4733.7 4737.5 4311.5 4466.6 4469.0 4492.8 4496.3 5158.4 5171.2 5186.6 5197.2 5201.6 3805.2 3810.3 3812.4 3814.8 3819.4 5242.0 5412.7 5421.3 5442.3 5446.3 3852.2 3868.3 3880.1 3891.2 3891.5 3930.6 3934.1 3947.9 3953.6 3958.7 4352.3 4441.3 4455.2 4459.8 4473.5 5160.6 5183.5 5185.9 5197.1 5206.9 1333.5 1373.5 1378.5 1383.5 1384.0 851.3 936.8 950.3 956.8 965.7 4511.4 4515.6 4522.8 4525.4 4530.2 5292.2 5296.9 5297.4 5300.4 5309.5 4415.9 4508.5 4518.9 4530.2 4535.8 2826.9 2827.4 2839.5 2846.7 2849.1 4924.6 4951.5 4986.2 5041.2 5045.4 5201.5 5396.2 5400.8 5415.2 5418.6 4968.6 5013.7 5031.3 5052.9 5059.3 5253.0 5264.7 5268.1 5274.7 5277.8 5026.7 5149.8 5159.3 5170.1 5176.6 4990.2 4998.9 5006.2 5007.3 5016.6 3875.2 3875.3 3878.3 3881.9 3899.9 5105.5 5219.8 5236.6 5260.4 5272.2 5045.9 5054.6 5061.0 5073.9 5086.6 5066.3 5071.8 5095.0 5095.6 5107.2 4795.7 5002.5 5109.5 5116.1 5130.2 4974.9 5059.9 5146.3 5224.2 5225.2 5102.7 5128.3 5133.1 5137.6 5154.1 06:47:13 INFO - PROCESS | 8454 | 06:47:13 INFO - PROCESS | 8454 | [#5] yui.html Cycles:180 Average:12912.24 Median:25582.92 stddev:15449.07 (60.4%) stddev-sans-first:15464.79 06:47:13 INFO - PROCESS | 8454 | Values: 611.6 637.8 679.0 685.5 705.3 11529.8 11892.0 11921.0 11940.6 11964.7 11314.9 11361.1 11369.1 11370.2 11432.0 637.9 776.3 789.5 813.1 813.4 808.4 814.2 814.2 814.3 814.6 850.6 863.2 864.5 865.8 865.8 669.4 833.1 854.7 859.9 860.0 630.9 631.6 632.0 632.1 632.3 11657.4 11771.4 11789.1 11859.6 11869.5 11718.6 12198.1 12396.0 12556.3 12733.9 8893.3 8940.0 8983.7 9018.8 9036.7 3954.3 4053.4 4124.0 4128.7 4129.3 44779.0 45231.1 45549.0 45596.8 45612.8 9200.4 9696.0 9822.5 9829.6 9995.7 16844.2 16867.6 16872.8 16889.1 17070.2 5890.0 5907.6 5925.4 5933.0 6152.8 3250.6 3336.6 3344.9 3381.0 3393.6 2712.1 2784.2 2794.4 2803.9 2805.7 424.9 497.2 502.2 505.2 512.1 425.3 505.9 540.1 546.5 558.2 7156.6 7233.9 7537.9 7571.7 7664.6 535.4 538.3 541.9 548.3 551.6 3416.9 3533.3 3550.8 3578.7 3694.7 56840.1 56958.7 56984.4 57111.4 57477.4 49008.8 49344.3 49694.3 50457.0 50653.7 45732.5 46234.5 46573.0 46631.5 47239.0 6949.9 7003.2 7105.7 7115.8 7156.0 30420.5 30453.1 30531.5 30969.4 31134.0 39835.2 41168.6 41534.6 41897.2 42108.6 9521.5 9613.5 9798.2 9900.3 9907.5 10723.8 10840.6 11049.0 11262.2 11457.4 8966.3 10902.2 10967.6 11064.8 11066.1 9416.2 9605.6 9768.7 9844.0 10025.5 11066.4 11259.4 11410.1 11549.8 11814.9 8971.6 9262.1 9431.8 9530.5 9674.2 8723.2 8876.6 8916.9 9028.3 9049.8 06:47:13 INFO - PROCESS | 8454 | -------- Summary: end -------- 06:47:13 INFO - PROCESS | 8454 | 06:47:14 INFO - TEST-INFO | 8454: exit 0 06:47:14 INFO - TEST-OK | dromaeo_css | took 1118376ms 06:47:14 INFO - TEST-START | kraken 06:47:14 INFO - operating with platform_type : linux_ 06:47:14 INFO - Initialising browser for kraken test... 06:47:14 INFO - TEST-INFO | started process 8632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFy4RFQ/profile http://localhost:51489/getInfo.html) 06:47:18 INFO - PROCESS | 8632 | __metrics Screen width/height:1600/1200 06:47:18 INFO - PROCESS | 8632 | colorDepth:24 06:47:18 INFO - PROCESS | 8632 | Browser inner width/height: 1024/697 06:47:18 INFO - PROCESS | 8632 | __metrics 06:47:19 ERROR - PROCESS | 8632 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:47:20 INFO - TEST-INFO | 8632: exit 0 06:47:20 INFO - Browser initialized. 06:47:20 INFO - Running cycle 1/1 for kraken test... 06:47:20 INFO - TEST-INFO | started process 8711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFy4RFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:32 INFO - PROCESS | 8711 | RSS: Main: 155758592 06:47:32 INFO - PROCESS | 8711 | 06:47:34 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:35 INFO - PROCESS | 8711 | RSS: Main: 210784256 06:47:35 INFO - PROCESS | 8711 | 06:47:38 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-dft) 06:47:39 INFO - PROCESS | 8711 | RSS: Main: 196186112 06:47:39 INFO - PROCESS | 8711 | 06:47:42 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-fft) 06:47:43 INFO - PROCESS | 8711 | RSS: Main: 266776576 06:47:43 INFO - PROCESS | 8711 | 06:47:45 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-oscillator) 06:47:45 INFO - PROCESS | 8711 | RSS: Main: 175230976 06:47:45 INFO - PROCESS | 8711 | 06:47:48 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:48 INFO - PROCESS | 8711 | RSS: Main: 179298304 06:47:48 INFO - PROCESS | 8711 | 06:47:51 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:52 INFO - PROCESS | 8711 | RSS: Main: 215126016 06:47:52 INFO - PROCESS | 8711 | 06:47:55 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:56 INFO - PROCESS | 8711 | RSS: Main: 216481792 06:47:56 INFO - PROCESS | 8711 | 06:47:59 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51489/tests/kraken/driver.html?testName=json-parse-financial) 06:47:59 INFO - PROCESS | 8711 | RSS: Main: 215928832 06:47:59 INFO - PROCESS | 8711 | 06:48:01 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:02 INFO - PROCESS | 8711 | RSS: Main: 200249344 06:48:02 INFO - PROCESS | 8711 | 06:48:04 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:04 INFO - PROCESS | 8711 | RSS: Main: 203042816 06:48:04 INFO - PROCESS | 8711 | 06:48:06 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:07 INFO - PROCESS | 8711 | RSS: Main: 219897856 06:48:07 INFO - PROCESS | 8711 | 06:48:10 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:10 INFO - PROCESS | 8711 | RSS: Main: 225542144 06:48:10 INFO - PROCESS | 8711 | 06:48:13 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:14 INFO - PROCESS | 8711 | RSS: Main: 218099712 06:48:14 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51489/tests/kraken/driver.html?testName=ai-astar) 06:48:16 INFO - PROCESS | 8711 | RSS: Main: 281686016 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | __start_tp_report 06:48:16 INFO - PROCESS | 8711 | _x_x_mozilla_page_load 06:48:16 INFO - PROCESS | 8711 | _x_x_mozilla_page_load_details 06:48:16 INFO - PROCESS | 8711 | |i|pagename|runs| 06:48:16 INFO - PROCESS | 8711 | |0;ai-astar;112;114;111;115;114;115;101;112;112;112 06:48:16 INFO - PROCESS | 8711 | |1;audio-beat-detection;155;132;156;188;130;161;159;141;201;138 06:48:16 INFO - PROCESS | 8711 | |2;audio-dft;161;162;161;161;162;161;161;163;161;166 06:48:16 INFO - PROCESS | 8711 | |3;audio-fft;73;74;129;112;75;76;74;117;100;74 06:48:16 INFO - PROCESS | 8711 | |4;audio-oscillator;94;93;147;94;93;95;145;93;94;151 06:48:16 INFO - PROCESS | 8711 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;116 06:48:16 INFO - PROCESS | 8711 | |6;imaging-darkroom;148;146;147;146;147;147;145;146;146;145 06:48:16 INFO - PROCESS | 8711 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;94;95 06:48:16 INFO - PROCESS | 8711 | |8;json-parse-financial;66;64;65;73;65;66;65;83;65;65 06:48:16 INFO - PROCESS | 8711 | |9;json-stringify-tinderbox;64;65;64;64;65;64;65;65;65;65 06:48:16 INFO - PROCESS | 8711 | |10;stanford-crypto-aes;89;81;79;78;79;79;80;81;81;79 06:48:16 INFO - PROCESS | 8711 | |11;stanford-crypto-ccm;143;136;133;139;131;138;132;130;175;143 06:48:16 INFO - PROCESS | 8711 | |12;stanford-crypto-pbkdf2;173;174;173;176;174;176;171;178;170;178 06:48:16 INFO - PROCESS | 8711 | |13;stanford-crypto-sha256-iterative;74;74;73;73;72;75;73;71;71;71 06:48:16 INFO - PROCESS | 8711 | __end_tp_report 06:48:16 INFO - PROCESS | 8711 | __start_cc_report 06:48:16 INFO - PROCESS | 8711 | _x_x_mozilla_cycle_collect,1887 06:48:16 INFO - PROCESS | 8711 | __end_cc_report 06:48:16 INFO - PROCESS | 8711 | __startTimestamp1461332896589__endTimestamp 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | ------- Summary: start ------- 06:48:16 INFO - PROCESS | 8711 | Number of tests: 14 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.05 (3.6%) stddev-sans-first:4.29 06:48:16 INFO - PROCESS | 8711 | Values: 112.0 114.0 111.0 115.0 114.0 115.0 101.0 112.0 112.0 112.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:157.50 stddev:23.30 (14.8%) stddev-sans-first:24.71 06:48:16 INFO - PROCESS | 8711 | Values: 155.0 132.0 156.0 188.0 130.0 161.0 159.0 141.0 201.0 138.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:1.60 (1.0%) stddev-sans-first:1.66 06:48:16 INFO - PROCESS | 8711 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 161.0 163.0 161.0 166.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#3] audio-fft Cycles:10 Average:90.40 Median:74.00 stddev:21.88 (29.6%) stddev-sans-first:22.29 06:48:16 INFO - PROCESS | 8711 | Values: 73.0 74.0 129.0 112.0 75.0 76.0 74.0 117.0 100.0 74.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.50 stddev:26.11 (27.9%) stddev-sans-first:27.05 06:48:16 INFO - PROCESS | 8711 | Values: 94.0 93.0 147.0 94.0 93.0 95.0 145.0 93.0 94.0 151.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:48:16 INFO - PROCESS | 8711 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 06:48:16 INFO - PROCESS | 8711 | Values: 148.0 146.0 147.0 146.0 147.0 147.0 145.0 146.0 146.0 145.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:48:16 INFO - PROCESS | 8711 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:65.50 stddev:5.95 (9.1%) stddev-sans-first:6.27 06:48:16 INFO - PROCESS | 8711 | Values: 66.0 64.0 65.0 73.0 65.0 66.0 65.0 83.0 65.0 65.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:48:16 INFO - PROCESS | 8711 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:3.13 (3.9%) stddev-sans-first:1.12 06:48:16 INFO - PROCESS | 8711 | Values: 89.0 81.0 79.0 78.0 79.0 79.0 80.0 81.0 81.0 79.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:138.50 stddev:13.16 (9.5%) stddev-sans-first:13.91 06:48:16 INFO - PROCESS | 8711 | Values: 143.0 136.0 133.0 139.0 131.0 138.0 132.0 130.0 175.0 143.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:2.71 (1.5%) stddev-sans-first:2.83 06:48:16 INFO - PROCESS | 8711 | Values: 173.0 174.0 173.0 176.0 174.0 176.0 171.0 178.0 170.0 178.0 06:48:16 INFO - PROCESS | 8711 | 06:48:16 INFO - PROCESS | 8711 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.42 (1.9%) stddev-sans-first:1.42 06:48:16 INFO - PROCESS | 8711 | Values: 74.0 74.0 73.0 73.0 72.0 75.0 73.0 71.0 71.0 71.0 06:48:16 INFO - PROCESS | 8711 | -------- Summary: end -------- 06:48:16 INFO - PROCESS | 8711 | 06:48:17 INFO - TEST-INFO | 8711: exit 0 06:48:17 INFO - TEST-OK | kraken | took 63480ms 06:48:17 INFO - SUITE-END | took 1181s 06:48:17 INFO - Completed test suite (00:19:41) 06:48:17 INFO - javascript benchmark 06:48:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.7428257174283, 2655.8539280339596, 2660.3881107345296, 2675.3579141006157, 2675.9197224083273, 4409.316555933828, 4495.617872480843, 4556.31655251712, 4562.63498920086, 4562.817487300508, 4551.294549344857, 4553.134904368168, 4644.7677616119145, 4666.066786642668, 4680.555347242015, 4196.181744559812, 4224.134052519242, 4243.809028593705, 4301.698881078326, 4385.320275357309, 4350.608445239928, 4363.80362883671, 4367.323064924942, 4393.428854248959, 4400.075984043355, 4124.649404800595, 4196.391523229146, 4208.621224089816, 4299.1831552005015, 4302.720323178999, 4205.663546916239, 4241.427407300037, 4244.087521182961, 4296.699231053827, 4306.332518459643, 4237.300845360512, 4254.936175957332, 4256.106217694288, 4277.294246449332, 4296.63478604319, 4346.217680817484, 4407.427034485529, 4469.843555475542, 4496.100779844044, 4551.499335073139, 4875.219964805649, 4875.829345972909, 4882.3408839806525, 4892.168331383637, 4939.703617782909, 4896.143174944371, 4905.4358748744, 4906.31311616374, 4940.752962351868, 4945.381827271591, 4479.216137175981, 4551.45382554089, 4597.126545956257, 4623.606993405531, 4635.860924172281, 4954.826581069645, 4975.676581022222, 4983.426905905795, 4988.0, 5019.071471777733, 4788.904221915612, 4791.616670666338, 4795.112904112751, 4797.56821886032, 4833.613310935187, 4736.834210802605, 4866.513348665105, 4905.901881962341, 5000.62495312853, 5003.5997120230295, 4877.975610121926, 4895.975520122377, 4906.386701662293, 4906.460289368167, 4952.5542701157065, 4889.926651100236, 4890.217565189552, 4897.715691879424, 4900.215965445583, 4947.1837146871085, 4015.2371049500503, 4046.2716710991717, 4050.23045621331, 4056.9188616228103, 4081.8571350002608, 3622.5471816022996, 3628.38317486028, 3643.143861192618, 3644.835982380799, 3645.690116340141, 4103.4870641169855, 4205.9789701051295, 4214.683898707609, 4256.1487702459635, 4262.381954616563, 4862.197737373364, 4917.606591472673, 4919.0899683558655, 4924.113659541245, 4971.229459433794, 4159.188958153191, 4214.388913607571, 4240.512341080754, 4247.532771395144, 4289.82840686369, 4380.4305440292555, 4444.688871778944, 4463.977680111643, 4474.440694913136, 4477.059817438309, 4644.8374306899095, 4667.089917466129, 4669.859904202879, 4670.0, 4719.032598317337, 4748.9050218994735, 4917.950820491749, 4919.311296418576, 4925.088858561177, 4970.726610036338, 4632.930506042345, 4675.111728771522, 4683.461401938821, 4716.0332131913565, 4726.432828060655, 4764.190087685032, 4780.426348838162, 4793.664443488922, 4794.232922732485, 4838.395200599925, 4687.39063921688, 4840.7337596431125, 4845.854624361275, 4865.878353041202, 4902.313676085422, 4751.239801631722, 4778.450478195052, 4783.545563171493, 4804.711717296974, 4823.855284341475, 4763.523647635208, 4765.451973023008, 4769.523047695203, 4773.427188737235, 4818.253170758538, 4565.406497155349, 4664.580187783115, 4664.930026049544, 4742.407199100113, 4758.191107511662, 4742.051589682146, 4772.236442169376, 4779.737114458738, 4822.662413631152, 4824.638152138674, 4684.391029166187, 4691.108689349013, 4695.624350052056, 4745.359376484269, 4754.904901902012], "value": 4506.780719264159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.1310460518432, 600.6936462404174, 617.02510034146, 632.0140580694116, 642.5534253693685, 27666.585001224972, 28402.43195136096, 34306.313873722545, 34697.826510867475, 35703.28593428136, 37506.437403438904, 38257.0, 38279.808600957025, 38307.425388619195, 38341.616583834155, 7612.69549218032, 7786.961065194666, 7791.883121753178, 7793.844123117534, 7794.532328060306, 7281.635918204095, 9615.903840961571, 10076.445795481246, 10078.596856125747, 10083.44541050242, 9804.558794854212, 9913.256505762061, 9921.0, 9924.05721456464, 9934.205263578897, 9599.184069354078, 9723.562439690195, 9728.124468797841, 9730.12428881404, 9739.707808765748, 9668.081532254424, 9777.46223957682, 9782.755431114208, 9782.902170978341, 9786.461744604045, 34959.30081398358, 38001.0, 38044.0, 38098.23803523942, 38146.809265953496, 3165.287283144998, 3174.5873036505336, 3186.6494685584566, 3196.4566023776015, 3197.9200519986953, 29293.414131717458, 29314.70685293141, 29717.0, 29844.55233171504, 30972.380552388826, 3182.5067114597273, 3198.072558957899, 3213.983930080358, 3246.870125194989, 3282.5404443377947, 234127.0, 234932.0, 235515.0, 235730.0, 236480.0, 54805.72597137069, 55189.72405138029, 55335.446645533026, 55342.72328638411, 55372.44627553673, 59330.70334648385, 59577.0, 59591.10613340804, 59621.10568341478, 59679.70160149172, 13842.169469831842, 14227.78658320126, 14244.501442449464, 14246.928765356313, 14307.78538321926, 9008.054154313833, 10527.315724477885, 10539.736506587396, 10585.259031867849, 10851.51168197433, 17087.401940932006, 17212.913935430493, 17237.741433878502, 17264.74102888458, 17273.222704978056, 5876.970615146983, 5960.910586341209, 6038.396160383926, 6057.42454466825, 6119.173911521976, 939.7650587353162, 988.7874107067015, 1011.8178727829062, 1031.0668844695563, 1034.1519953638094, 27826.860865695948, 28062.43875122486, 28500.85749571239, 28656.283592909927, 28716.856415718205, 1029.5418538750334, 1038.5638032026416, 1040.8230600797883, 1082.3235477826358, 1120.910327173824, 14890.851091488947, 15218.771718424012, 15254.161021143722, 15551.766723499157, 15552.688946221013, 332288.0, 336527.0, 337877.0, 339604.0, 339791.0, 48866.0, 49596.75201623969, 49597.50402496001, 49670.0, 49825.50174498281, 1058.724731569782, 1078.8921107889148, 1255.2217625072512, 1268.9175203611735, 1349.3455673998103, 24512.75487245105, 25306.240812775646, 25838.61242081408, 25945.870270648527, 25971.87014064993, 35101.64898350984, 35260.29479410346, 35405.468917965736, 35489.64510354863, 35562.64437355697, 184552.0, 184792.0, 185115.0, 185528.0, 185914.0, 32014.0, 33203.50194747032, 38998.0, 39530.81407557778, 39850.20299593934, 39195.0, 40259.1948161041, 40290.395644065946, 40390.79804600958, 40525.1894962105, 33512.49731253985, 33984.9022646605, 34109.317813644084, 34176.31647366989, 34545.48181777326, 33271.0, 33455.832720837214, 33866.0, 34104.829475853454, 34138.65861341355, 33777.0, 33833.15417114592, 34160.82919585386, 34649.133771655914, 34864.30271394608, 29866.253343666584, 30622.0, 30868.53697194499, 31044.22389440282, 31073.68926310708, 23683.763162368847, 24227.198034093635, 24429.877850610632, 24486.87756561206, 24552.631710523998], "value": 17410.51819330769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6573151298076, 380.885734279716, 388.8716723481252, 389.0875896023824, 389.7661403158104, 15691.136987465685, 16366.509004729847, 16783.664326713457, 16794.580135496617, 16806.915965420172, 15347.386104555804, 16350.264238109285, 16638.750418743697, 16649.084300363476, 16654.16729163543, 4897.755112244383, 5163.948360516403, 5186.4813518648025, 5189.558887494549, 5203.401608814978, 3671.706263498927, 3925.1757131002523, 5514.476124768141, 5905.616134951236, 5907.4683278505145, 5757.712114394284, 5856.941430585683, 5876.382979787125, 5879.559033072515, 5883.941160588403, 5680.346760122577, 5701.458361455655, 5723.198752174678, 5724.656520608777, 5842.240508733858, 3358.395488812013, 4852.611791056743, 5193.8961220775755, 5203.16749320107, 5204.219367094928, 19039.238430462763, 19446.027698615013, 19459.513512162168, 20715.5856882863, 20785.0, 1902.771667399907, 2057.809916532195, 2342.4495243617735, 2452.730199678034, 2565.0381107084845, 12920.547780827626, 13217.140885842486, 13265.403056862368, 13626.386812593457, 13703.862961370358, 1711.9441796393503, 1745.24954269664, 1749.457668122886, 1773.733939909024, 1785.8392744652913, 67588.0, 67663.66168169127, 68114.65942670305, 68664.3133568668, 69455.0, 9441.811163776685, 9530.428174309563, 9544.570494327772, 9814.607415703435, 9819.214462842956, 13461.86538134606, 13595.728085438433, 13601.795973060413, 13615.25116118623, 13627.454901804014, 7008.299170082951, 7069.116360454943, 7121.92878071223, 7160.10498687664, 7270.091238595176, 6708.563943343667, 6732.663366831639, 6761.22245941723, 6842.93157068423, 6887.449004079662, 6082.928121298716, 6119.143319935212, 6146.508279337642, 6153.1693221415435, 6185.103160041859, 1640.4996476074673, 1641.5813967438228, 1740.4430582213822, 1741.8171092035407, 1784.4289827255413, 895.7984453498041, 942.236788201559, 957.368137029571, 969.8787651543557, 1019.6940917724801, 15693.686126277638, 15908.204589770465, 16623.6675266494, 17003.74494382585, 17497.092763216737, 881.5592203898051, 906.664534122379, 929.1359036096495, 941.2046820436857, 957.674390707149, 5634.7182640867795, 5704.3154821421695, 9554.856677149848, 9964.20286377088, 10116.190704743603, 281686.0, 284465.0, 284629.0, 285796.0, 285888.0, 78772.60613696894, 80581.59709201417, 82090.58954705189, 82883.0, 82957.0, 458.8852786803299, 461.35640781110163, 461.38405229019634, 462.4173541337938, 467.14512442230637, 9477.668281610111, 9869.605215791287, 10179.847302290324, 10322.638707645196, 10532.736681582715, 25888.611670824575, 27690.0, 28132.296692582848, 31540.36919261648, 34547.136321591155, 44800.55199447964, 45527.31709024434, 49426.75286623544, 49978.500214998836, 49998.750006249735, 7532.585707786125, 7555.639984802789, 7571.772846814604, 7774.2614451627005, 7926.256223630792, 5904.852378690567, 10979.937423153484, 11781.293122412682, 12284.0, 12637.810432843698, 10778.892211078102, 10813.729656758644, 10881.945590271998, 10909.399983000694, 10920.617778377718, 10562.947185264025, 10603.257771955889, 10696.304740191863, 10773.407462589634, 10825.837612435662, 10402.791944161227, 10730.946345268223, 10909.236353455182, 10915.39965301916, 11080.833787493355, 7803.804904877424, 7822.882656760039, 7997.480163789568, 8201.548914809742, 8316.085230624747, 9314.573920978222, 10683.94658026705, 10719.035286824223, 10755.0, 10818.67543973682], "value": 7999.458971337902, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.7434513097382, 1433.1114708880496, 1470.9558713238603, 1611.2024547848816, 1814.7912990006146, 6861.931380686192, 7594.354479869211, 7808.336291415222, 7811.06267247931, 7828.021497312836, 7550.546967181973, 7692.4615276930635, 7701.345385642213, 7716.305532502074, 7728.65221065052, 1848.3438379375264, 2169.5443956769095, 2205.151016858505, 2229.2532001779423, 2235.1394713035515, 2203.746569144545, 2222.4554984028937, 2226.309843948373, 2227.0201111510883, 2229.9554008919813, 2165.415337858777, 2225.4881377283236, 2226.677131815886, 2228.832837537183, 2229.476073122823, 1864.5431869192066, 2165.826733861295, 2238.6194346961056, 2243.6634504824406, 2248.15694114707, 2140.9357719268446, 2156.3746513511064, 2162.048698572623, 2162.37291185556, 2187.57342318248, 7823.452358334919, 7844.37245020397, 7849.45053846231, 7905.644246008944, 7907.881381779278, 4471.0610771737975, 4640.559146881041, 4643.86068417948, 4652.4184476940045, 4694.718316900997, 3012.4426981008364, 3041.6654168041496, 3086.35186610812, 3098.8915387961315, 3137.5293705944064, 962.6486332488661, 972.4554249620236, 986.1716158426884, 989.7228775942675, 997.760537471009, 10956.233063685624, 10963.0, 10963.397013164273, 10974.286671366335, 11012.779744405147, 4263.253930562139, 4335.588119128678, 4423.579759922803, 4441.0673758511075, 4446.755428451402, 9325.0, 9346.439213647067, 9359.532023398802, 9382.202512786353, 9387.953060234655, 4185.351270553069, 4672.159011377917, 4684.812607495662, 4691.81232750693, 4702.224133018082, 4259.680523960654, 4370.0604370059955, 4370.322599997005, 4391.385206071152, 4411.558844115562, 3748.55017397914, 3771.773693578394, 3835.520559930009, 3879.1465877506903, 3881.0879443330796, 1256.340421278836, 1276.4128500889694, 1283.3519072868328, 1283.6020833541631, 1285.7107150890974, 726.077881091022, 809.7368355284556, 887.1572006593761, 907.7367563406539, 909.9044600317004, 5185.325907631984, 5290.127129023668, 5337.733113344318, 5360.276362690986, 5404.351477822686, 835.4402550291319, 853.7108965462197, 868.3574155125162, 898.3531857062904, 947.8767760191131, 3619.149499867529, 3673.669369756681, 3694.3350196964266, 3694.8891533254045, 3734.8506059757847, 9575.664851730156, 9910.752231194278, 10058.49707514636, 10093.293469457214, 10108.292419530562, 9934.304598678023, 9963.601455941825, 9967.80064398708, 9976.301658883953, 9981.201503879673, 7027.297270273034, 7070.363667269868, 7140.285971402818, 7231.819204519929, 7239.239879812649, 5213.061648903234, 5231.581473482189, 5237.973810130925, 5653.293338332708, 5695.914561281501, 8826.161514656098, 8969.282457403522, 9003.54982250898, 9077.137671921157, 9080.091990800867, 8711.0, 9262.53687315645, 9333.579988900652, 9496.287778416508, 9528.761780955254, 5974.61165024272, 6152.446279834837, 6159.81520554384, 6933.826654333682, 7031.367176954099, 6474.093626892333, 6584.242812076481, 7214.927850721426, 7253.963730181315, 7307.817304567428, 6677.666116694243, 6842.178938527409, 6865.691043902936, 6923.273056329013, 6955.269696681776, 6582.967085164543, 6636.535442519171, 6642.667866606554, 6726.260111387841, 6766.627835469097, 6072.78745243932, 6130.141780150693, 6189.442950134509, 6194.938050619436, 6198.783042593487, 4844.515548445127, 4850.757462126809, 4886.706797592155, 4956.8760780980765, 4988.401391833003, 4801.831935882367, 4820.325154478306, 4851.927221091757, 4894.045661096052, 4942.4810394909455], "value": 4208.97961956369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.71337439617156, 318.8469534623381, 319.4361951156208, 319.6867070271134, 324.3642460776877, 4905.877353066175, 4974.65177437579, 4982.750862456881, 4990.800367985285, 5000.0, 4901.926471102927, 4909.386326709161, 4922.950770492294, 4925.901481970367, 4942.431620363659, 3667.651573100551, 3740.8129593520353, 3853.2678791029753, 3857.688385948777, 3914.8825535233846, 3870.4581358609817, 3877.4490203918376, 3896.08442016126, 3902.2585708715255, 3917.099067214542, 3647.1246900743895, 3858.9195025392937, 3861.826217820191, 3871.690264778811, 3878.1080351519167, 3793.089658481972, 3893.6761501089763, 3922.195949830278, 3932.5870783567884, 3933.2723446162267, 3470.236547959445, 3486.860525578974, 3486.860525578974, 3487.459443786217, 3494.7204223662047, 4709.1288111699105, 4728.858134255978, 4733.266343716729, 4733.692309999839, 4737.502562230985, 4311.525732169459, 4466.55334466554, 4469.01128997593, 4492.775361231958, 4496.2581174106235, 5158.380994280673, 5171.172612382001, 5186.559142472895, 5197.246399272084, 5201.55786758126, 3805.219929914361, 3810.333191691471, 3812.3519001769764, 3814.771113733185, 3819.3888977763704, 5242.0, 5412.675239485604, 5421.2952316199035, 5442.346918369782, 5446.346438427414, 3852.1910398816563, 3868.3423817951016, 3880.1075752577067, 3891.2412079644764, 3891.5330160380367, 3930.587288334741, 3934.11482416454, 3947.9013024674036, 3953.584873588232, 3958.7030972677167, 4352.337750896874, 4441.267905516851, 4455.1980643484485, 4459.821607135678, 4473.463184417826, 5160.638755287094, 5183.50756678115, 5185.948140518622, 5197.116490196676, 5206.947930520646, 1333.5399287245884, 1373.478078330228, 1378.4968486502355, 1383.4950243161175, 1383.9584812455641, 851.284920666643, 936.7939053408239, 950.2682934140673, 956.8469044952774, 965.7006328038331, 4511.390962220124, 4515.616172625298, 4522.796474158671, 4525.366448697185, 4530.207213737583, 5292.179712144623, 5296.867578310496, 5297.3643162819935, 5300.363956325188, 5309.46905309466, 4415.867523974286, 4508.549145085531, 4518.864434066983, 4530.22986092365, 4535.818567257273, 2826.9293267668063, 2827.3638431353193, 2839.48889199946, 2846.694177716015, 2849.059810262608, 4924.581410580141, 4951.455339912607, 4986.202207646759, 5041.168207245837, 5045.445001049881, 5201.479852014768, 5396.244525766396, 5400.83797486076, 5415.160650099241, 5418.593605479605, 4968.552830245295, 5013.699178049329, 5031.320771695848, 5052.873678158076, 5059.2916991621205, 5253.0, 5264.73676316175, 5268.130758424817, 5274.657147285414, 5277.762500687555, 5026.723530205728, 5149.7682604282145, 5159.277701121771, 5170.146925757208, 5176.585873130065, 4990.176620857518, 4998.87502812418, 5006.1739812930455, 5007.3240112584335, 5016.620429381949, 3875.2055828554517, 3875.321818681663, 3878.26313000529, 3881.902952426212, 3899.863504777319, 5105.5149760772665, 5219.817306394258, 5236.581073514186, 5260.421353651019, 5272.156454967187, 5045.8738531537, 5054.595632349477, 5060.987802439453, 5073.8731531712, 5086.64393492452, 5066.341375621146, 5071.797128114982, 5094.974525127351, 5095.592352611856, 5107.157319042465, 4795.736234507136, 5002.474740152232, 5109.46350633193, 5116.079105760999, 5130.230465430215, 4974.850754477371, 5059.898802023865, 5146.305248791366, 5224.164133738584, 5225.216217567396, 5102.69383836971, 5128.256402821496, 5133.10170720115, 5137.563307118788, 5154.098032844162], "value": 3922.829757000066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.636076534462, 637.7927173668558, 678.9781379024573, 685.479035932691, 705.3193668110275, 11529.769404611914, 11892.0, 11921.0, 11940.582079627215, 11964.700882477942, 11314.943425282883, 11361.091112710963, 11369.09047276218, 11370.204085714004, 11432.0, 637.894747366684, 776.2819392062348, 789.4631650477672, 813.1177672225642, 813.3574476163824, 808.3613944983456, 814.2020819596798, 814.2183503836295, 814.3363159025405, 814.5642081486405, 850.6002178975872, 863.1886027134505, 864.4640322999749, 865.8225063861893, 865.8398196333699, 669.3674477618653, 833.0503226321937, 854.7179430787825, 859.8624220124781, 859.9981022109235, 630.93690630937, 631.6368088349171, 631.9684015799191, 632.0708558419117, 632.2918331468738, 11657.417129143509, 11771.411429428494, 11789.05687545003, 11859.584914528037, 11869.46587403569, 11718.589849355232, 12198.10929305959, 12396.0, 12556.309402982832, 12733.936330318382, 8893.28853691703, 8939.955300223522, 8983.685571004984, 9018.774530636721, 9036.728898133066, 3954.307996100671, 4053.4122552230056, 4123.958760412387, 4128.710990230685, 4129.29801933669, 44779.0, 45231.09537809291, 45549.0, 45596.772016140036, 45612.77193614044, 9200.401973871676, 9695.951520242354, 9822.508874556386, 9829.606815727433, 9995.650152244636, 16844.157792110345, 16867.578310542336, 16872.818902676696, 16889.071101089314, 17070.23183956725, 5889.970550147222, 5907.616004959664, 5925.4370834770625, 5933.0, 6152.753889844445, 3250.6099268087983, 3336.6162891267813, 3344.916377090592, 3380.983095084509, 3393.6267010628812, 2712.145674112648, 2784.1647505748197, 2794.385235248242, 2803.9158825235277, 2805.719428057219, 424.9043965107826, 497.1846172277468, 502.24913753938097, 505.2068252843001, 512.101262284688, 425.28552032584935, 505.9443461219263, 540.0899484368773, 546.472653888999, 558.187836697604, 7156.642167891689, 7233.89149162763, 7537.886931696029, 7571.697132114764, 7664.578448185403, 535.4404647143745, 538.2598926476095, 541.9485148910848, 548.3200830969569, 551.5863102672995, 3416.9145771355916, 3533.3286675531567, 3550.786952782841, 3578.6779189873037, 3694.7228957827733, 56840.147397789064, 56958.71520642453, 56984.43015569874, 57111.428885711444, 57477.42522574804, 49008.75495622499, 49344.25983610249, 49694.25458618124, 50457.0, 50653.74673126611, 45732.542674573495, 46234.537654623025, 46573.0, 46631.533684663395, 47239.0, 6949.861002779815, 7003.159620845531, 7105.680244388912, 7115.82210444743, 7156.0, 30420.543691844196, 30453.086407407813, 30531.54202686917, 30969.380612388075, 31134.0, 39835.20329593334, 41168.588314116474, 41534.58465415307, 41897.162056759305, 42108.57891421169, 9521.523923803921, 9613.51932403363, 9798.216142708423, 9900.257480688833, 9907.504624768588, 10723.839142413026, 10840.620578279722, 11049.0, 11262.155338349492, 11457.427128643702, 8966.282697384064, 10902.236843420884, 10967.616133435291, 11064.778704425706, 11066.059384952368, 9416.152546270869, 9605.567749451431, 9768.706938791847, 9844.0, 10025.5488503019, 11066.446677666245, 11259.437028148395, 11410.14423918193, 11549.826752598885, 11814.94092529532, 8971.551422428984, 9262.120098590623, 9431.764205894908, 9530.523473826419, 9674.177694896012, 8723.214910658071, 8876.556172191495, 8916.885389326335, 9028.322875784212, 9049.77375565616], "value": 5767.687771092145, "unit": "score"}], "name": "dromaeo_css", "value": 6253.082195187603, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 111.0, 115.0, 114.0, 115.0, 101.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 156.0, 188.0, 130.0, 161.0, 159.0, 141.0, 201.0, 138.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 166.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 129.0, 112.0, 75.0, 76.0, 74.0, 117.0, 100.0, 74.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 147.0, 94.0, 93.0, 95.0, 145.0, 93.0, 94.0, 151.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 73.0, 65.0, 66.0, 65.0, 83.0, 65.0, 65.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 79.0, 78.0, 79.0, 79.0, 80.0, 81.0, 81.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 133.0, 139.0, 131.0, 138.0, 132.0, 130.0, 175.0, 143.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 173.0, 176.0, 174.0, 176.0, 171.0, 178.0, 170.0, 178.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 72.0, 75.0, 73.0, 71.0, 71.0, 71.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1587.6, "alertThreshold": 2.0}]} 06:48:17 INFO - Return code: 0 06:48:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:48:17 ERROR - # TBPL SUCCESS # 06:48:17 INFO - Running post-action listener: _resource_record_post_action 06:48:17 INFO - Running post-run listener: _resource_record_post_run 06:48:18 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295067648; Read time: 8; Write time: 227164 06:48:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13631488; Read time: 0; Write time: 3196 06:48:18 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281436160; Read time: 8; Write time: 223968 06:48:18 INFO - Running post-run listener: _upload_blobber_files 06:48:18 INFO - Blob upload gear active. 06:48:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:48:18 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:18 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:20 INFO - (blobuploader) - INFO - Done attempting. 06:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:22 INFO - (blobuploader) - INFO - Done attempting. 06:48:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:22 INFO - Return code: 0 06:48:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d256658ab38f2c7163144294816d8966ed801d7de8ff3100bd19e7625baa0c07e6469674537ba79a523b0b2251aa62c5332716f1c90907e6eb686d276014224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a03c3abfe1589d4ed98d7f13dcfd401148116b3268278d7005100585481fcb5a9dd12b81d5f777e012254275a70f98519519b3f4e2b249c1c03624f9aee84f3a"} 06:48:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:22 INFO - Contents: 06:48:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d256658ab38f2c7163144294816d8966ed801d7de8ff3100bd19e7625baa0c07e6469674537ba79a523b0b2251aa62c5332716f1c90907e6eb686d276014224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a03c3abfe1589d4ed98d7f13dcfd401148116b3268278d7005100585481fcb5a9dd12b81d5f777e012254275a70f98519519b3f4e2b249c1c03624f9aee84f3a"} 06:48:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:22 INFO - Copying logs to upload dir... 06:48:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.566589 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-22 06:48:21.676155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:21.679509) ========= 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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d256658ab38f2c7163144294816d8966ed801d7de8ff3100bd19e7625baa0c07e6469674537ba79a523b0b2251aa62c5332716f1c90907e6eb686d276014224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a03c3abfe1589d4ed98d7f13dcfd401148116b3268278d7005100585481fcb5a9dd12b81d5f777e012254275a70f98519519b3f4e2b249c1c03624f9aee84f3a"} build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d256658ab38f2c7163144294816d8966ed801d7de8ff3100bd19e7625baa0c07e6469674537ba79a523b0b2251aa62c5332716f1c90907e6eb686d276014224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a03c3abfe1589d4ed98d7f13dcfd401148116b3268278d7005100585481fcb5a9dd12b81d5f777e012254275a70f98519519b3f4e2b249c1c03624f9aee84f3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:21.707596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:21.707975) ========= 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=7de08804244eb36560b44971000001c3-1461331653.94268-819205457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:48:21.790727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:48:21.791130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:48:21.791496) ========= ========= Total master_lag: 0.18 =========