builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1461498932.96 results: success (0) buildid: 20160424023004 builduid: e2f255b3f47146f2affdf52a5e073dcd revision: f9177e655c8c7c3250087d71c0b6fed5e335e1b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:32.959010) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:32.959363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:32.959617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:32.998898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:32.999148) ========= 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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 04:55: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% 26.2M=0s 2016-04-24 04:55:33 (26.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.102617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.102888) ========= 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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.152545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.152876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9177e655c8c7c3250087d71c0b6fed5e335e1b5 --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 f9177e655c8c7c3250087d71c0b6fed5e335e1b5 --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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 04:55:34,002 truncating revision to first 12 chars 2016-04-24 04:55:34,002 Setting DEBUG logging. 2016-04-24 04:55:34,002 attempt 1/10 2016-04-24 04:55:34,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9177e655c8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 04:55:34,269 unpacking tar archive at: fx-team-f9177e655c8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.720776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.721050) ========= script_repo_revision: f9177e655c8c7c3250087d71c0b6fed5e335e1b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.721389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.721641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 04:55:33.735192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-24 04:55:33.735444) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:55:34 INFO - MultiFileLogger online at 20160424 04:55:34 in /builds/slave/test 04:55:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:55:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:34 INFO - {'append_to_log': False, 04:55:34 INFO - 'base_work_dir': '/builds/slave/test', 04:55:34 INFO - 'blob_upload_branch': 'Fx-Team', 04:55:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:34 INFO - 'branch': 'Fx-Team', 04:55:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:34 INFO - 'config_files': ('talos/linux_config.py',), 04:55:34 INFO - 'default_actions': ('clobber', 04:55:34 INFO - 'read-buildbot-config', 04:55:34 INFO - 'download-and-extract', 04:55:34 INFO - 'populate-webroot', 04:55:34 INFO - 'create-virtualenv', 04:55:34 INFO - 'install', 04:55:34 INFO - 'run-tests'), 04:55:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:34 INFO - 'download_minidump_stackwalk': True, 04:55:34 INFO - 'download_symbols': 'ondemand', 04:55:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:34 INFO - 'installer_path': 'installer.exe', 04:55:34 INFO - 'log_level': 'info', 04:55:34 INFO - 'log_name': 'talos', 04:55:34 INFO - 'log_to_console': True, 04:55:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:55:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:55:34 INFO - 'opt_config_files': (), 04:55:34 INFO - 'pip_index': False, 04:55:34 INFO - 'sps_profile': False, 04:55:34 INFO - 'sps_profile_interval': 0, 04:55:34 INFO - 'suite': 'dromaeojs', 04:55:34 INFO - 'system_bits': '32', 04:55:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:34 INFO - 'title': 'talos-linux64-ix-043', 04:55:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:34 INFO - 'use_talos_json': True, 04:55:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:34 INFO - 'work_dir': 'build'} 04:55:34 INFO - ##### 04:55:34 INFO - ##### Running clobber step. 04:55:34 INFO - ##### 04:55:34 INFO - Running pre-action listener: _resource_record_pre_action 04:55:34 INFO - Running main action method: clobber 04:55:34 INFO - rmtree: /builds/slave/test/build 04:55:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:35 INFO - Running post-action listener: _resource_record_post_action 04:55:35 INFO - ##### 04:55:35 INFO - ##### Running read-buildbot-config step. 04:55:35 INFO - ##### 04:55:35 INFO - Running pre-action listener: _resource_record_pre_action 04:55:35 INFO - Running main action method: read_buildbot_config 04:55:35 INFO - Using buildbot properties: 04:55:35 INFO - { 04:55:35 INFO - "project": "", 04:55:35 INFO - "product": "firefox", 04:55:35 INFO - "script_repo_revision": "production", 04:55:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:55:35 INFO - "repository": "", 04:55:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:55:35 INFO - "buildid": "20160424023004", 04:55:35 INFO - "pgo_build": "True", 04:55:35 INFO - "basedir": "/builds/slave/test", 04:55:35 INFO - "buildnumber": 605, 04:55:35 INFO - "slavename": "talos-linux64-ix-043", 04:55:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:55:35 INFO - "platform": "ubuntu64_hw", 04:55:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:55:35 INFO - "branch": "fx-team", 04:55:35 INFO - "repo_path": "integration/fx-team", 04:55:35 INFO - "revision": "f9177e655c8c7c3250087d71c0b6fed5e335e1b5", 04:55:35 INFO - "stage_platform": "linux64-pgo", 04:55:35 INFO - "builduid": "e2f255b3f47146f2affdf52a5e073dcd", 04:55:35 INFO - "slavebuilddir": "test" 04:55:35 INFO - } 04:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:55:35 INFO - Running post-action listener: _resource_record_post_action 04:55:35 INFO - ##### 04:55:35 INFO - ##### Running download-and-extract step. 04:55:35 INFO - ##### 04:55:35 INFO - Running pre-action listener: _resource_record_pre_action 04:55:35 INFO - Running main action method: download_and_extract 04:55:35 INFO - mkdir: /builds/slave/test/build/tests 04:55: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')]} 04:55:35 INFO - https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:55:47 INFO - Downloaded 1361 bytes. 04:55:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:55:47 INFO - Using the following test package requirements: 04:55:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:55:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:55:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'jsshell-linux-x86_64.zip'], 04:55:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:55:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:55:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:55:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:55:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:55:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:47 INFO - https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:55:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:55:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:55:59 INFO - Downloaded 23857749 bytes. 04:55:59 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'] 04:55:59 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 04:56:00 INFO - Return code: 0 04:56:00 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 04:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:00 INFO - https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:56:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:56:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:01 INFO - Downloaded 23857749 bytes. 04:56:01 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'] 04:56:01 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 04:56:03 INFO - Return code: 0 04:56:03 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')]} 04:56:03 INFO - https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:04 INFO - Downloaded 10840145 bytes. 04:56:04 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'] 04:56:04 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 04:56:04 INFO - Return code: 0 04:56: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')]} 04:56:04 INFO - https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:56:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:56:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:56:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cz3ruuW2RrGfSYg26SGzIg/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 04:56:07 INFO - Downloaded 58355547 bytes. 04:56:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:56:07 INFO - mkdir: /builds/slave/test/properties 04:56:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:07 INFO - Contents: 04:56:07 INFO - build_url:https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:56:08 INFO - Running post-action listener: _resource_record_post_action 04:56:08 INFO - Running post-action listener: set_extra_try_arguments 04:56:08 INFO - ##### 04:56:08 INFO - ##### Running populate-webroot step. 04:56:08 INFO - ##### 04:56:08 INFO - Running pre-action listener: _resource_record_pre_action 04:56:08 INFO - Running main action method: populate_webroot 04:56:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:08 INFO - '--tppagecycles', 04:56:08 INFO - '7'], 04:56:08 INFO - 'tests': ['tsvgm']}}, 04:56:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['damp', 'tps']}, 04:56:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'tests': ['damp', 'tps']}, 04:56:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['dromaeo_dom']}, 04:56:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['a11yr', 04:56:08 INFO - 'ts_paint', 04:56:08 INFO - 'tpaint', 04:56:08 INFO - 'sessionrestore', 04:56:08 INFO - 'sessionrestore_no_auto_restore', 04:56:08 INFO - 'tabpaint']}, 04:56:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['tsvgx', 04:56:08 INFO - 'tsvgr_opacity', 04:56:08 INFO - 'tart', 04:56:08 INFO - 'tscrollx', 04:56:08 INFO - 'cart']}, 04:56:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:08 INFO - 'tsvgr_opacity', 04:56:08 INFO - 'tart', 04:56:08 INFO - 'tscrollx', 04:56:08 INFO - 'cart']}, 04:56:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'talos_options': ['--disable-e10s'], 04:56:08 INFO - 'tests': ['tp5o']}, 04:56:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'tests': ['tp5o']}, 04:56:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'talos_options': ['--disable-e10s', 04:56:08 INFO - '--xperf_path', 04:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:08 INFO - 'tests': ['tp5n']}, 04:56:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:08 INFO - 'talos_options': ['--xperf_path', 04:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:08 INFO - 'tests': ['tp5n']}}, 04:56:08 INFO - 'talos.zip': {'path': '', 04:56:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:08 INFO - Running post-action listener: _resource_record_post_action 04:56:08 INFO - ##### 04:56:08 INFO - ##### Running create-virtualenv step. 04:56:08 INFO - ##### 04:56:08 INFO - Running pre-action listener: _resource_record_pre_action 04:56:08 INFO - Running main action method: create_virtualenv 04:56:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:08 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 04:56:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:08 INFO - Using real prefix '/usr' 04:56:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:10 INFO - Installing pip.................done. 04:56:10 INFO - Return code: 0 04:56:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:10 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')]} 04:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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')]} 04:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:10 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 04:56:10 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 04:56:10 INFO - Using env: {'DISPLAY': ':0', 04:56:10 INFO - 'HOME': '/home/cltbld', 04:56:10 INFO - 'LANG': 'en_US.UTF-8', 04:56:10 INFO - 'LANGUAGE': 'en_US:en', 04:56:10 INFO - 'LOGNAME': 'cltbld', 04:56:10 INFO - 'MAIL': '/var/mail/cltbld', 04:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:10 INFO - 'MOZ_NO_REMOTE': '1', 04:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:10 INFO - 'NO_EM_RESTART': '1', 04:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:10 INFO - 'PWD': '/builds/slave/test', 04:56:10 INFO - 'SHELL': '/bin/bash', 04:56:10 INFO - 'SHLVL': '1', 04:56:10 INFO - 'TERM': 'linux', 04:56:10 INFO - 'TMOUT': '86400', 04:56:10 INFO - 'USER': 'cltbld', 04:56:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:10 INFO - '_': '/tools/buildbot/bin/python'} 04:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:10 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 04:56:10 INFO - Cleaning up... 04:56:10 INFO - Return code: 0 04:56:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:56:10 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')]} 04:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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')]} 04:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:10 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 04:56:10 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 04:56:10 INFO - Using env: {'DISPLAY': ':0', 04:56:10 INFO - 'HOME': '/home/cltbld', 04:56:10 INFO - 'LANG': 'en_US.UTF-8', 04:56:10 INFO - 'LANGUAGE': 'en_US:en', 04:56:10 INFO - 'LOGNAME': 'cltbld', 04:56:10 INFO - 'MAIL': '/var/mail/cltbld', 04:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:10 INFO - 'MOZ_NO_REMOTE': '1', 04:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:10 INFO - 'NO_EM_RESTART': '1', 04:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:10 INFO - 'PWD': '/builds/slave/test', 04:56:10 INFO - 'SHELL': '/bin/bash', 04:56:10 INFO - 'SHLVL': '1', 04:56:10 INFO - 'TERM': 'linux', 04:56:10 INFO - 'TMOUT': '86400', 04:56:10 INFO - 'USER': 'cltbld', 04:56:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:10 INFO - '_': '/tools/buildbot/bin/python'} 04:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:11 INFO - Downloading/unpacking psutil>=0.7.1 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:13 INFO - Installing collected packages: psutil 04:56:13 INFO - Running setup.py install for psutil 04:56:13 INFO - building 'psutil._psutil_linux' extension 04:56:13 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 04:56:13 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 04:56:13 INFO - building 'psutil._psutil_posix' extension 04:56:13 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 04:56:13 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 04:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:13 INFO - Successfully installed psutil 04:56:13 INFO - Cleaning up... 04:56:13 INFO - Return code: 0 04:56:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:56:13 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')]} 04:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 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')]} 04:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:13 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 04:56:13 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 04:56:13 INFO - Using env: {'DISPLAY': ':0', 04:56:13 INFO - 'HOME': '/home/cltbld', 04:56:13 INFO - 'LANG': 'en_US.UTF-8', 04:56:13 INFO - 'LANGUAGE': 'en_US:en', 04:56:13 INFO - 'LOGNAME': 'cltbld', 04:56:13 INFO - 'MAIL': '/var/mail/cltbld', 04:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:13 INFO - 'MOZ_NO_REMOTE': '1', 04:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:13 INFO - 'NO_EM_RESTART': '1', 04:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:13 INFO - 'PWD': '/builds/slave/test', 04:56:13 INFO - 'SHELL': '/bin/bash', 04:56:13 INFO - 'SHLVL': '1', 04:56:13 INFO - 'TERM': 'linux', 04:56:13 INFO - 'TMOUT': '86400', 04:56:13 INFO - 'USER': 'cltbld', 04:56:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:13 INFO - '_': '/tools/buildbot/bin/python'} 04:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:56:13 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 04:56:13 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 04:56:13 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 04:56:13 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 04:56:13 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 04:56:13 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 04:56:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:15 INFO - Installing collected packages: mozsystemmonitor 04:56:15 INFO - Running setup.py install for mozsystemmonitor 04:56:15 INFO - Successfully installed mozsystemmonitor 04:56:15 INFO - Cleaning up... 04:56:16 INFO - Return code: 0 04:56:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:16 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:16 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 04:56:16 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 04:56:16 INFO - Using env: {'DISPLAY': ':0', 04:56:16 INFO - 'HOME': '/home/cltbld', 04:56:16 INFO - 'LANG': 'en_US.UTF-8', 04:56:16 INFO - 'LANGUAGE': 'en_US:en', 04:56:16 INFO - 'LOGNAME': 'cltbld', 04:56:16 INFO - 'MAIL': '/var/mail/cltbld', 04:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:16 INFO - 'MOZ_NO_REMOTE': '1', 04:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:16 INFO - 'NO_EM_RESTART': '1', 04:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:16 INFO - 'PWD': '/builds/slave/test', 04:56:16 INFO - 'SHELL': '/bin/bash', 04:56:16 INFO - 'SHLVL': '1', 04:56:16 INFO - 'TERM': 'linux', 04:56:16 INFO - 'TMOUT': '86400', 04:56:16 INFO - 'USER': 'cltbld', 04:56:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:16 INFO - '_': '/tools/buildbot/bin/python'} 04:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:16 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 04:56:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 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 04:56:18 INFO - Downloading docopt-0.6.1.tar.gz 04:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:18 INFO - Running setup.py install for blobuploader 04:56:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:18 INFO - Running setup.py install for requests 04:56:19 INFO - Running setup.py install for docopt 04:56:19 INFO - Successfully installed blobuploader requests docopt 04:56:19 INFO - Cleaning up... 04:56:19 INFO - Return code: 0 04:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:19 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:19 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 04:56:19 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 04:56:19 INFO - Using env: {'DISPLAY': ':0', 04:56:19 INFO - 'HOME': '/home/cltbld', 04:56:19 INFO - 'LANG': 'en_US.UTF-8', 04:56:19 INFO - 'LANGUAGE': 'en_US:en', 04:56:19 INFO - 'LOGNAME': 'cltbld', 04:56:19 INFO - 'MAIL': '/var/mail/cltbld', 04:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:19 INFO - 'MOZ_NO_REMOTE': '1', 04:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:19 INFO - 'NO_EM_RESTART': '1', 04:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:19 INFO - 'PWD': '/builds/slave/test', 04:56:19 INFO - 'SHELL': '/bin/bash', 04:56:19 INFO - 'SHLVL': '1', 04:56:19 INFO - 'TERM': 'linux', 04:56:19 INFO - 'TMOUT': '86400', 04:56:19 INFO - 'USER': 'cltbld', 04:56:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:19 INFO - '_': '/tools/buildbot/bin/python'} 04:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:19 INFO - Running setup.py (path:/tmp/pip-WZgriN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:19 INFO - Running setup.py (path:/tmp/pip-Aa4E3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:19 INFO - Running setup.py (path:/tmp/pip-rnUfSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:19 INFO - Running setup.py (path:/tmp/pip-cV0xoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:19 INFO - Running setup.py (path:/tmp/pip-RZ_ovj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:19 INFO - Running setup.py (path:/tmp/pip-CFKH78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:20 INFO - Running setup.py (path:/tmp/pip-OmALfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:20 INFO - Running setup.py (path:/tmp/pip-FGFjD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:20 INFO - Running setup.py (path:/tmp/pip-zmHBQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:20 INFO - Running setup.py (path:/tmp/pip-DhJuHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:20 INFO - Running setup.py (path:/tmp/pip-3UFELD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:20 INFO - Running setup.py (path:/tmp/pip-pP56UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:20 INFO - Running setup.py (path:/tmp/pip-uZK1rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:20 INFO - Running setup.py (path:/tmp/pip-cX8CE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:20 INFO - Running setup.py (path:/tmp/pip-s_A5Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:20 INFO - Running setup.py (path:/tmp/pip-tXU3qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:20 INFO - Running setup.py (path:/tmp/pip-FtGBUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:20 INFO - Running setup.py install for manifestparser 04:56:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:20 INFO - Running setup.py install for mozcrash 04:56:21 INFO - Running setup.py install for mozdebug 04:56:21 INFO - Running setup.py install for mozdevice 04:56:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozfile 04:56:21 INFO - Running setup.py install for mozhttpd 04:56:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozinfo 04:56:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozInstall 04:56:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozleak 04:56:21 INFO - Running setup.py install for mozlog 04:56:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for moznetwork 04:56:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozprocess 04:56:22 INFO - Running setup.py install for mozprofile 04:56:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for mozrunner 04:56:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for mozscreenshot 04:56:22 INFO - Running setup.py install for moztest 04:56:22 INFO - Running setup.py install for mozversion 04:56:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:22 INFO - Cleaning up... 04:56:22 INFO - Return code: 0 04:56:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:22 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 04:56:22 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 04:56:22 INFO - Using env: {'DISPLAY': ':0', 04:56:22 INFO - 'HOME': '/home/cltbld', 04:56:22 INFO - 'LANG': 'en_US.UTF-8', 04:56:22 INFO - 'LANGUAGE': 'en_US:en', 04:56:22 INFO - 'LOGNAME': 'cltbld', 04:56:22 INFO - 'MAIL': '/var/mail/cltbld', 04:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:22 INFO - 'MOZ_NO_REMOTE': '1', 04:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:22 INFO - 'NO_EM_RESTART': '1', 04:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:22 INFO - 'PWD': '/builds/slave/test', 04:56:22 INFO - 'SHELL': '/bin/bash', 04:56:22 INFO - 'SHLVL': '1', 04:56:22 INFO - 'TERM': 'linux', 04:56:22 INFO - 'TMOUT': '86400', 04:56:22 INFO - 'USER': 'cltbld', 04:56:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:22 INFO - '_': '/tools/buildbot/bin/python'} 04:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:22 INFO - Running setup.py (path:/tmp/pip-QCSbtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:22 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)) 04:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:22 INFO - Running setup.py (path:/tmp/pip-k50GVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:22 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)) 04:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:22 INFO - Running setup.py (path:/tmp/pip-BlcYPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:23 INFO - Running setup.py (path:/tmp/pip-rTgpHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:23 INFO - Running setup.py (path:/tmp/pip-GTD9dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:23 INFO - Running setup.py (path:/tmp/pip-UyrUSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:23 INFO - Running setup.py (path:/tmp/pip-6SWRaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:23 INFO - Running setup.py (path:/tmp/pip-pR3Yrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:23 INFO - Running setup.py (path:/tmp/pip-Fb_tpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:23 INFO - Running setup.py (path:/tmp/pip-OW7syW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:23 INFO - Running setup.py (path:/tmp/pip-CqJojS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:23 INFO - Running setup.py (path:/tmp/pip-u8kuXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:23 INFO - Running setup.py (path:/tmp/pip-De55yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:23 INFO - Running setup.py (path:/tmp/pip-qHMc3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:23 INFO - Running setup.py (path:/tmp/pip-etpMSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:23 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)) 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:23 INFO - Running setup.py (path:/tmp/pip-Vh7CGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:24 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)) 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:24 INFO - Running setup.py (path:/tmp/pip-fsUqr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:24 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)) 04:56:24 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)) 04:56:24 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)) 04:56:24 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)) 04:56:24 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)) 04:56:24 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)) 04:56:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:25 INFO - Downloading blessings-1.6.tar.gz 04:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:26 INFO - Installing collected packages: blessings 04:56:26 INFO - Running setup.py install for blessings 04:56:26 INFO - Successfully installed blessings 04:56:26 INFO - Cleaning up... 04:56:26 INFO - Return code: 0 04:56:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:26 INFO - Reading from file tmpfile_stdout 04:56:26 INFO - Current package versions: 04:56:26 INFO - argparse == 1.2.1 04:56:26 INFO - blessings == 1.6 04:56:26 INFO - blobuploader == 1.2.4 04:56:26 INFO - docopt == 0.6.1 04:56:26 INFO - manifestparser == 1.1 04:56:26 INFO - mozInstall == 1.12 04:56:26 INFO - mozcrash == 0.17 04:56:26 INFO - mozdebug == 0.1 04:56:26 INFO - mozdevice == 0.48 04:56:26 INFO - mozfile == 1.2 04:56:26 INFO - mozhttpd == 0.7 04:56:26 INFO - mozinfo == 0.9 04:56:26 INFO - mozleak == 0.1 04:56:26 INFO - mozlog == 3.1 04:56:26 INFO - moznetwork == 0.27 04:56:26 INFO - mozprocess == 0.22 04:56:26 INFO - mozprofile == 0.28 04:56:26 INFO - mozrunner == 6.11 04:56:26 INFO - mozscreenshot == 0.1 04:56:26 INFO - mozsystemmonitor == 0.0 04:56:26 INFO - moztest == 0.7 04:56:26 INFO - mozversion == 1.4 04:56:26 INFO - psutil == 3.1.1 04:56:26 INFO - requests == 1.2.3 04:56:26 INFO - wsgiref == 0.1.2 04:56:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:26 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')]} 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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')]} 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:26 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 04:56:26 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 04:56:26 INFO - Using env: {'DISPLAY': ':0', 04:56:26 INFO - 'HOME': '/home/cltbld', 04:56:26 INFO - 'LANG': 'en_US.UTF-8', 04:56:26 INFO - 'LANGUAGE': 'en_US:en', 04:56:26 INFO - 'LOGNAME': 'cltbld', 04:56:26 INFO - 'MAIL': '/var/mail/cltbld', 04:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:26 INFO - 'MOZ_NO_REMOTE': '1', 04:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:26 INFO - 'NO_EM_RESTART': '1', 04:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:26 INFO - 'PWD': '/builds/slave/test', 04:56:26 INFO - 'SHELL': '/bin/bash', 04:56:26 INFO - 'SHLVL': '1', 04:56:26 INFO - 'TERM': 'linux', 04:56:26 INFO - 'TMOUT': '86400', 04:56:26 INFO - 'USER': 'cltbld', 04:56:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:26 INFO - '_': '/tools/buildbot/bin/python'} 04:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 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)) 04:56:26 INFO - Cleaning up... 04:56:26 INFO - Return code: 0 04:56:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56:26 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')]} 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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')]} 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:26 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 04:56:26 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 04:56:26 INFO - Using env: {'DISPLAY': ':0', 04:56:26 INFO - 'HOME': '/home/cltbld', 04:56:26 INFO - 'LANG': 'en_US.UTF-8', 04:56:26 INFO - 'LANGUAGE': 'en_US:en', 04:56:26 INFO - 'LOGNAME': 'cltbld', 04:56:26 INFO - 'MAIL': '/var/mail/cltbld', 04:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:26 INFO - 'MOZ_NO_REMOTE': '1', 04:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:26 INFO - 'NO_EM_RESTART': '1', 04:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:26 INFO - 'PWD': '/builds/slave/test', 04:56:26 INFO - 'SHELL': '/bin/bash', 04:56:26 INFO - 'SHLVL': '1', 04:56:26 INFO - 'TERM': 'linux', 04:56:26 INFO - 'TMOUT': '86400', 04:56:26 INFO - 'USER': 'cltbld', 04:56:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:26 INFO - '_': '/tools/buildbot/bin/python'} 04:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:26 INFO - Downloading/unpacking jsonschema 04:56:26 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 04:56:26 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 04:56:26 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 04:56:26 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 04:56:26 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 04:56:26 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 04:56:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:28 INFO - Downloading/unpacking functools32 (from jsonschema) 04:56:28 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 04:56:28 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 04:56:28 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 04:56:28 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 04:56:28 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 04:56:28 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 04:56:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:28 INFO - warning: no files found matching '*.txt' 04:56:28 INFO - no previously-included directories found matching 'build' 04:56:28 INFO - no previously-included directories found matching 'dist' 04:56:28 INFO - no previously-included directories found matching '.git*' 04:56:29 INFO - Installing collected packages: jsonschema, functools32 04:56:29 INFO - Running setup.py install for functools32 04:56:29 INFO - warning: no files found matching '*.txt' 04:56:29 INFO - no previously-included directories found matching 'build' 04:56:29 INFO - no previously-included directories found matching 'dist' 04:56:29 INFO - no previously-included directories found matching '.git*' 04:56:29 INFO - Successfully installed jsonschema functools32 04:56:29 INFO - Cleaning up... 04:56:29 INFO - Return code: 0 04:56:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 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 0x7f7b33546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, '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': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', '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 04:56:29 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 04:56:29 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 04:56:29 INFO - Using env: {'DISPLAY': ':0', 04:56:29 INFO - 'HOME': '/home/cltbld', 04:56:29 INFO - 'LANG': 'en_US.UTF-8', 04:56:29 INFO - 'LANGUAGE': 'en_US:en', 04:56:29 INFO - 'LOGNAME': 'cltbld', 04:56:29 INFO - 'MAIL': '/var/mail/cltbld', 04:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:29 INFO - 'MOZ_NO_REMOTE': '1', 04:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:29 INFO - 'NO_EM_RESTART': '1', 04:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:29 INFO - 'PWD': '/builds/slave/test', 04:56:29 INFO - 'SHELL': '/bin/bash', 04:56:29 INFO - 'SHLVL': '1', 04:56:29 INFO - 'TERM': 'linux', 04:56:29 INFO - 'TMOUT': '86400', 04:56:29 INFO - 'USER': 'cltbld', 04:56:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:29 INFO - '_': '/tools/buildbot/bin/python'} 04:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:29 INFO - Downloading/unpacking flake8 04:56:29 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 04:56:29 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 04:56:29 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 04:56:29 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 04:56:29 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 04:56:29 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 04:56:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:56:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:56:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 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 04:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:56:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:32 INFO - no previously-included directories found matching 'docs/_build' 04:56:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:56:32 INFO - Running setup.py install for pep8 04:56:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:32 INFO - no previously-included directories found matching 'docs/_build' 04:56:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:56:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:56:32 INFO - Cleaning up... 04:56:32 INFO - Return code: 0 04:56:32 INFO - Running post-action listener: _resource_record_post_action 04:56:32 INFO - Running post-action listener: _start_resource_monitoring 04:56:32 INFO - Starting resource monitoring. 04:56:32 INFO - ##### 04:56:32 INFO - ##### Running install step. 04:56:32 INFO - ##### 04:56:32 INFO - Running pre-action listener: _resource_record_pre_action 04:56:32 INFO - Running main action method: install 04:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:32 INFO - Reading from file tmpfile_stdout 04:56:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:32 INFO - Reading from file tmpfile_stdout 04:56:32 INFO - Output received: 04:56:32 INFO - Usage: mozinstall [options] installer 04:56:32 INFO - Options: 04:56:32 INFO - -h, --help show this help message and exit 04:56:32 INFO - -d DEST, --destination=DEST 04:56:32 INFO - Directory to install application into. [default: 04:56:32 INFO - "/builds/slave/test"] 04:56:32 INFO - --app=APP Application being installed. [default: firefox] 04:56:32 INFO - mkdir: /builds/slave/test/build/application 04:56:32 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'] 04:56:32 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 04:56:49 INFO - Reading from file tmpfile_stdout 04:56:49 INFO - Output received: 04:56:49 INFO - /builds/slave/test/build/application/firefox/firefox 04:56:49 INFO - Running post-action listener: _resource_record_post_action 04:56:49 INFO - ##### 04:56:49 INFO - ##### Running run-tests step. 04:56:49 INFO - ##### 04:56:49 INFO - Running pre-action listener: _resource_record_pre_action 04:56:49 INFO - Running main action method: run_tests 04:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:56:49 INFO - Python 2.7.3 04:56:49 INFO - Return code: 0 04:56:49 INFO - grabbing minidump binary from tooltool 04:56:49 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')]} 04:56:49 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 0x1d4a810>, '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 0x1d4b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4bba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:56:49 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 04:56:49 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 04:56:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:49 INFO - Return code: 0 04:56:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:56:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:56:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:56:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:56:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:56:50 INFO - Return code: 0 04:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 04:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 04:56:50 INFO - Using env: {'DISPLAY': ':0', 04:56:50 INFO - 'HOME': '/home/cltbld', 04:56:50 INFO - 'LANG': 'en_US.UTF-8', 04:56:50 INFO - 'LANGUAGE': 'en_US:en', 04:56:50 INFO - 'LOGNAME': 'cltbld', 04:56:50 INFO - 'MAIL': '/var/mail/cltbld', 04:56:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:50 INFO - 'MOZ_NO_REMOTE': '1', 04:56:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:50 INFO - 'NO_EM_RESTART': '1', 04:56:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:50 INFO - 'PWD': '/builds/slave/test', 04:56:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:50 INFO - 'SHELL': '/bin/bash', 04:56:50 INFO - 'SHLVL': '1', 04:56:50 INFO - 'TERM': 'linux', 04:56:50 INFO - 'TMOUT': '86400', 04:56:50 INFO - 'USER': 'cltbld', 04:56:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461488770.775658-21447094', 04:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:50 INFO - '_': '/tools/buildbot/bin/python'} 04:56:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 04:56:50 INFO - mozversion application_buildid: 20160424023004 04:56:50 INFO - mozversion application_changeset: f9177e655c8c7c3250087d71c0b6fed5e335e1b5 04:56:50 INFO - mozversion application_display_name: Nightly 04:56:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:50 INFO - mozversion application_name: Firefox 04:56:50 INFO - mozversion application_remotingname: firefox 04:56:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:56:50 INFO - mozversion application_vendor: Mozilla 04:56:50 INFO - mozversion application_version: 48.0a1 04:56:50 INFO - mozversion platform_buildid: 20160424023004 04:56:50 INFO - mozversion platform_changeset: f9177e655c8c7c3250087d71c0b6fed5e335e1b5 04:56:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:56:50 INFO - mozversion platform_version: 48.0a1 04:56:50 INFO - using testdate: 1461499010 04:56:50 INFO - actual date: 1461499010 04:56:50 INFO - starting webserver on 'localhost:44533' 04:56:50 INFO - SUITE-START | Running 2 tests 04:56:50 INFO - TEST-START | dromaeo_css 04:56:50 INFO - operating with platform_type : linux_ 04:56:50 INFO - Initialising browser for dromaeo_css test... 04:56:50 INFO - TEST-INFO | started process 5272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvBTnY/profile http://localhost:44533/getInfo.html) 04:56:54 INFO - PROCESS | 5272 | __metrics Screen width/height:1600/1200 04:56:54 INFO - PROCESS | 5272 | colorDepth:24 04:56:54 INFO - PROCESS | 5272 | Browser inner width/height: 1024/697 04:56:54 INFO - PROCESS | 5272 | __metrics 04:56:55 ERROR - PROCESS | 5272 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:56:56 INFO - TEST-INFO | 5272: exit 0 04:56:56 INFO - Browser initialized. 04:56:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:56 INFO - TEST-INFO | started process 5355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvBTnY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:08 INFO - PROCESS | 5355 | RSS: Main: 153763840 04:57:08 INFO - PROCESS | 5355 | 04:57:59 INFO - PROCESS | 5355 | 1461499079345 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:00:06 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44533/tests/dromaeo/cssquery-ext.html) 05:00:07 INFO - PROCESS | 5355 | RSS: Main: 249090048 05:00:07 INFO - PROCESS | 5355 | 05:03:10 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-ext.html (next: http://localhost:44533/tests/dromaeo/cssquery-jquery.html) 05:03:10 INFO - PROCESS | 5355 | RSS: Main: 232767488 05:03:10 INFO - PROCESS | 5355 | 05:06:12 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44533/tests/dromaeo/cssquery-mootools.html) 05:06:13 INFO - PROCESS | 5355 | RSS: Main: 232411136 05:06:13 INFO - PROCESS | 5355 | 05:09:15 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44533/tests/dromaeo/cssquery-prototype.html) 05:09:15 INFO - PROCESS | 5355 | RSS: Main: 230244352 05:09:15 INFO - PROCESS | 5355 | 05:12:18 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44533/tests/dromaeo/cssquery-yui.html) 05:12:19 INFO - PROCESS | 5355 | RSS: Main: 211013632 05:12:19 INFO - PROCESS | 5355 | 05:15:21 INFO - PROCESS | 5355 | Cycle 1(1): loaded http://localhost:44533/tests/dromaeo/cssquery-yui.html (next: http://localhost:44533/tests/dromaeo/cssquery-dojo.html) 05:15:22 INFO - PROCESS | 5355 | RSS: Main: 278790144 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | __start_tp_report 05:15:22 INFO - PROCESS | 5355 | _x_x_mozilla_page_load 05:15:22 INFO - PROCESS | 5355 | _x_x_mozilla_page_load_details 05:15:22 INFO - PROCESS | 5355 | |i|pagename|runs| 05:15:22 INFO - PROCESS | 5355 | |0;dojo.html;3096.4116817804615;3140.9371812563736;3158.9999999999986;3162.2726772842248;3191.632962209346;5276.762545685444;5320.521153096221;5339.038414545958;5367.141257398817;5415.620906536544;5327.934413117373;5366.677999320033;5379.757910894009;5388.245645609608;5437.238786569874;4863.124637565228;4872.317875497433;4882.3408839806525;4894.632902532307;4946.480619534951;4871.196252618313;4887.584555312803;4910.263460480921;4916.827911023115;4924.729139897304;4798;4824.734639594821;4849.636277279201;4933.925991110136;4946.901061978776;4892.461829198785;4912.7297998610065;4913.1893237616105;4921.950780492185;4954.975225123887;4892.706437613719;4894.535019173173;4896.951030489685;4905.730184839832;4909.165441874889;5165.405978312505;5215.8174463893965;5254.710990895499;5259.105951988171;5317.760700768475;5710.343310519302;5713.6000479966415;5741.913871291934;5744.138379243105;5746.569007324468;5651.2935883014625;5656.179853921159;5750.482456578928;5765.077587586008;5768.048272035109;5252.842414727565;5274.683518988873;5276.287701160371;5283.577313814885;5315.973420132913;5725.055365864586;5729.799457018984;5733.426657334317;5736;5795.391483894215;5477.507024367826;5495.175723641406;5503.229547863302;5553.666779993133;5642.774289028475;5712.485876271156;5717.2281741965135;5723.7996670116345;5730;5746.310442746813;5677.1768093627015;5697.145428185805;5697.515711164598;5697.601167918288;5702.600817942704;5482.259894914136;5681.147827825859;5686.43135686428;5761.251037365116;5770.596058275881;4326.048269380732;4332.241857674894;4332.501762297313;4332.696711230184;4363.781810909441;3860.1507668312925;3873.128860043956;3892.82482288292;3921.058945852975;3928.548216955087;5221.7128057956415;5302.284191634157;5358.2498450217;5461.563074954073;5463.098588732814;5731.598788084794;5732.197492351074;5738.540916726652;5752.9712351437975;5771.913421298684;5409.540189083893;5409.891802163935;5439.292891924025;5451.427600102012;5451.863703407367;4808.3989501312335;4827.034593081397;4879.536444037811;4904.5340692634145;4923.384576927884;5960.821175364746;5986.3714309997695;5990.041593345044;5990.700464976734;5994.7602095916545;5734.5125664319;5765.798197063083;5766.8846623066465;5767.5385969121535;5769.711514424178;5737.8565535861935;5739;5883.0293001654245;5897.292324921037;5943.078822782476;5650.85872853182;5674.659520428788;5679.574031947703;5684.261046063985;5684.346300175367;5584.441555844383;5792.652440853562;5794.768209271582;5802.593818432669;5804.013317736079;5542.2795036644975;5601.439856014366;5608.803691870765;5639.3232812062815;5656.490915817596;5509.449055094618;5509.5041446270025;5511.090670039559;5512.39363670004;5516.558675306046;5365.839024829262;5441.428649991693;5444.3194600674915;5453.590980676545;5494;5651.915221271602;5657.830265092054;5660.971695141498;5686.772529098956;5740.913886291625;5526.336839579276;5528.889422211453;5529.695866727368;5539.307586551681;5581.832545023656 05:15:22 INFO - PROCESS | 5355 | |1;ext.html;606.766394937949;637.735339833969;650.5381179362653;656.5043392238862;661.2792056658242;34095.14762130945;38058.80970595147;39045.60954390455;39143.41284880729;39157.21685566294;40970.59029409705;41492.37761433573;41640;41659.37510937338;41874.37188442176;7697.34572561333;8444.113368096354;8623.65505379784;8635.568221588896;9911.454869982148;10040.447775372351;10185.643502477415;10201.081902628763;10210.081092701656;10214.336068155584;10222.897771022306;10293.588256469733;10295.691129266097;10311.690649280534;10311.84532232017;9846;9875.160611348045;9878.654247101389;9885.110340069356;9886.209103271722;10017.098461138532;10128.240381971382;10133.847992280122;10134.442605656686;10567.894321056845;40981.79509102435;41406.79296603498;41469.37795933063;41474;41487.792561037;3541.3094446582927;3704.944425833615;3717.70258379329;3940.704447166474;4204.285271503852;29545;32039.199020024455;32416;32557.511637325224;33372.499412508834;4246;4262.658987281041;4281.229378711831;4288.099499105192;4295.076558539898;304475;306360;306535.46732266416;307328;307421;35414;36352.45471317879;36379.09052273662;36428.27143457116;59891.70054149701;34320.31359372799;34342.14144646354;34428.48357274643;34500.65499345025;34512.65487345144;13255.072144949761;14140.50508232207;14220.288985550887;14231.217283049531;14240.074395164282;12085.939570302093;12348.567800126952;12350.258984460961;12360.134790564754;12376.938115309365;8347.373946954003;8386.622601982803;8387.958060209781;8424.115467875907;8460.746177614681;3059.831709255968;3133.8903138390046;3234.207619133327;3274.9672503274664;3325.118843506473;1109.9455517258637;1130.621241883978;1142.3945308986251;1173.5892437646755;1209.2986068080493;29862.850685746867;30032.699673003426;30583.541246881316;30613.38773224523;30729.231769205948;1134.2570616246371;1144.9141314401286;1154.1516985016005;1180.451090243041;1230.5262473947594;16824.663506729798;16868.24092915822;17100.91449542744;17102.57243568896;17136.22886970089;446565;453231;453970;454825;455577;54573.181402279;56463;56520;56528;56672.71663641655;1384.210999730144;1396.8952328575397;1400.6848459096623;1419.4038503828417;1514.136941943104;30226;30915.845420772752;31305.53041704331;31321.37357252888;31362.21594460157;51064.74467627638;51204;51457;51565.22652160146;51839.222411663104;377219;380293;380780;380820;380946;25330.36674083089;26019.21942341733;26384.20847374505;27828.44343113167;28257.71742282551;41241.793791030854;41515.58484415117;41683.37474937939;41750.16499670051;41816.1636767269;34393.82803085969;35076.12309692278;35381.469277960336;35511.28977420489;35561.1109722259;34702.47946280858;34711.785087521814;34755.478667819494;34894.476582850766;34920.65079349174;36456.27087458183;38482.6151738479;39854.800725997346;39928.60071399249;39935.400968984904;32039.83980080178;33761.66238337585;33990.49014264739;34014.65985340214;34065.31869362549;25705;26129.60805587956;26203.475930481665;26431.20706378812;26765.86617066902 05:15:22 INFO - PROCESS | 5355 | |2;jquery.html;385.76853887667386;388.60944750525715;393.3146467387246;396.5518963571165;400.13770324949724;14212.218327991955;15101.848981510182;17942.820571794276;18414.17136228871;18441.907790461046;13893.722125557482;17528.29886804526;17640.647187056253;17936.730949035777;18521.722174167397;5489.64317319375;5549.833504994836;5659.236003139565;5663.348714897798;5676.432356764331;3917.2165566886592;5385.649932754378;5567.8608034799045;5593.804216852411;5935.85160370992;6160.1375807387;6167.568270221086;6187.938120618804;6189.628622282655;6199.628022318675;6086.239220097488;6159.076138579204;6183.165272688175;6192.721327540272;6197.969010154966;5346.251524786533;5422.267993820863;5448.8365349039195;5461.890762184774;5480.479354461319;21193.152273909025;21488;21811.890940545356;22089.889550552307;22282.777172228234;2367.786899179082;2432.2824766693866;2439.329184474266;2505.922453345061;2513.5349960257413;13411.329433528284;13538.458461661521;13738;13986.510472133426;14345.426182952773;1954.1890115602007;1969.5076230942263;1971.2312198242696;1979.4160722586728;2096.7693553709078;70360.29639703639;72979;73372.63313683397;74836;75024.62487687527;10097.697069087939;10232.64185753495;10580.682579522627;11154.330740155616;11269.54921803135;14216.360263788154;14363.856361436252;14369.209693466959;14376.496822611367;14435.566932992027;7271.309225623558;7631.236876312324;7863.528188308605;8089.31240844523;8233.46482478649;7635.465517413728;7666.386689064973;7774.572398518023;7811.140774514799;7824.334931530883;4403.933940990888;4459.799309031101;4466.151431228056;4504.504504504502;4565.817367305337;1831.2400353853268;1836.779586449608;1839.4849442156217;1842.5218081680118;1843.4653950354248;983.9704808855746;1010.8534262532039;1021.382063851374;1028.7222449938624;1075.7471994081384;17626.383076592516;18314;18521.35175268859;18698.158582863805;18708.345207917657;989.5547003848297;1000.5347513406301;1004.317064396203;1009.7526106104051;1056.529844219315;10096.899031009743;10333.22500812442;10348.793024139475;10506.474676266309;10605.522751476203;467190;471281;484658;484974;491680;92814.53592732128;96070;96361;97230.51384743172;97284;995.9452230127413;1017.0287375556474;1018.8471729240673;1051.2903789941759;1052.8526006359116;16161.27274272684;16208.67582648364;16336.754948676016;16403;16473.588160296087;28320.575191372558;38392.04019899525;39597.40603891001;40060;40299.59700402959;38747.41878871876;52098.47901520936;52196.73901630467;52750.73624631852;55322;7606.315431611181;7973.80065498344;7990.760277191694;8064.435489515912;8065;6417.518686098468;9083.45499270046;12352.320622365856;12464.376781160725;12574.87425125737;10104.292699510963;10625.9468702656;10704.946475267885;11070.501827417624;11224.270422422516;10206.693799186036;10632.468376580986;10809.243352965217;10933.781324373309;11002.634433596815;6711.4966377520905;8271.62777674994;11025.228234023862;11037.337759734442;11213.738779264153;7694.615269236404;7978.880316795136;8071.354291656771;8095.514269143635;8241.381896357678;8150.021997360354;10861.930014825077;11424.885751142714;11456.140789440658;12026.098042646661 05:15:22 INFO - PROCESS | 5355 | |3;mootools.html;1348.2719331560957;1488.4269556220854;1507.8416766239545;1639.6966561186182;1765.2938824470211;7901.881471777928;8159.10249872515;8183.754487365373;8196.959015204931;8218.589070546479;7791.259830316125;7899.407544434176;7911.327537159334;7916.6833326666865;7924.603769811501;1996.3711430899293;2180.6292930201826;2245.4498647831265;2255.1994042115057;2295.5523672883796;2250.2799104286637;2260.1298500077505;2273.4884650953486;2277.886105694717;2278.236790675126;2239.596872562938;2279.327598358488;2285.5200407914276;2287.1194590082855;2289.7939185473306;1955.6577598920203;2176.8027584828283;2229.55408918217;2232.0290673557056;2234.084025549533;2104.5685634444903;2117.269542008005;2117.9046942887608;2123.182574708733;2182.3125715399756;8194.09864914859;8254.958725206336;8359.164083591591;8378.706745263886;8485.109063548362;4993.151164302078;5132.666376685504;5135.332406787131;5169.224616307546;5187.870303242411;3370.831458427069;3403.9829800851085;3438.7592868499214;3471.3230919970615;3506.561679790026;1117.1956191542076;1129.9096072314196;1140.41838662282;1162.2096974057638;1177.7526719388939;11429.828552571718;11431.885681143165;11445.25605835618;11463.197576169672;11477.655670329903;4376.168527979674;4398.626116780046;4524.864254072383;4551.06703125865;4628.74541900192;9777.853332200022;9808;9819.41083534976;9826.361286516354;9839.262055345878;4597.42532183477;5124.282600435942;5134.178531434953;5153;5156.510131537498;4291.03451723366;4317.848875289413;4434.157510073076;4540.182767101887;4565.748883811356;3814.732968692165;3920.4903362562686;3930.9017274568364;3961.9801900990888;3970.662493688011;1253.11029169289;1263.406199086428;1276.1577358943052;1287.2598256002836;1287.6265882893856;751.9548827070394;785.4815821557744;915.3729695158837;930.734740598926;964.0167029629738;5486.725663716878;5613.635113717595;5738.68437235956;5742.885142297131;5744.540436765049;963.8024205038091;1018.9032041956002;1020.413262374123;1031.9896801032044;1045.6706137566794;3903.4144878268485;3978.4430179774854;3984.402339649018;3989.6808255340084;4006.3189257825657;9964.302498825013;10094;10269.435181065113;10305.381677099398;10317.48412579368;10193.592256309665;10202.897971020195;10213.489325533694;10241.74395640115;10249.487525623688;7449.88825167623;7489.962550187323;7510.098788145458;7517;7530.209328020588;5628.718564071862;5671.177679236405;5792.739326730223;5835.153902684172;5932.4957378621575;9452.574634141618;9479.383840050376;9630.807383852143;9651.662191823252;9680.27397945143;9015.188633023059;9464.526773661428;9727.513624318897;9746.976567460599;9881.851772223567;6396.552241343062;6599.175103112111;6608.669566521751;7040.507164498641;7167.104111986002;7744.186860379579;7956.283934445928;7971.960140199262;7998.640061197377;8010.319122874621;7037.296270372922;7230.240824713329;7245.637718113968;7340.265973402617;7346.77959661211;7125.251848555827;7150.284971502808;7151.8569628608175;7197.470996868518;7262.237465066303;6774.593524388552;6843.623600702009;6856.24581296047;6867.965660171667;6870.828229294308;4957.281194226889;4990.6506544541535;5019.171836646912;5059.772310245974;5071.011152825164;4978.975105124451;4988.575971042502;5013.573846223112;5085.7457127144235;5104.234364845154 05:15:22 INFO - PROCESS | 5355 | |4;prototype.html;317.9904602861914;319.3772144318579;325.90385836178325;330.1827975759993;331.4577192930225;5582.8325150245555;5642.774289028439;5707.543396528273;5738.139279108136;5850.239468869041;5569.164625306206;5627.859303517414;5645.407232240617;5656.802011929583;5678.063119585264;4325.307950727884;4330.5669433056755;4339.739615623057;4343.543927887574;4352.7605981670995;4081.7346872453345;4144.191882582898;4300.462442194726;4336.783160841961;4339.956600434002;4248.745075295476;4265.253580623394;4271.231178387889;4277.165952639237;4285.378620100084;4076.4700588923547;4262.339337402707;4281.473930381059;4282;4299.849505267332;3642.1623026704005;3746.5316835395574;3753.530808648919;3761.6614504694435;3769.208466222097;5406.91889621656;5409.9459005409835;5416.837494875121;5429.782808687648;5459.3994660587305;4774.880627984294;4889.804407823683;4905.3623029006;4914.216053638714;4920.876978075541;5832.2418085649015;5852.853678658025;5869.383714709979;5883.52931765462;5903.822885313448;4111.876643700693;4113.691473139526;4115.074108325633;4131.462909821704;4136.276151673475;5892.941070589325;6022.548308876808;6122.693865306762;6145.754169833202;6188.350223226586;4174.08170202555;4191.91616167675;4196.307609244502;4200.390943313202;4201.34879093741;4235.597618226264;4251.29853574163;4253.97873010633;4265.424167737316;4276.550962148992;4756.881077973078;4918.458969513351;4926.852194434173;4936.777844996984;4953.975230123826;5900.524868782804;5931.716289228678;5933.821985340447;5938.940610593925;5969.432903874212;1458.941642334316;1470.3824393754649;1474.2481334519473;1476.1069552920328;1488.9553313400615;896.4397251717677;941.4304345870787;945.2579724915907;955.0544960489066;956.4404823178379;5546.362168350611;5711.314642242957;5718.142278658234;5732.312122545238;5744.281964754406;5981.641101533834;6035.853187894286;6036.849078772978;6100.145979562864;6134.263888333339;5670.489655930904;5784.293633378164;5786.189933409326;5788.305403351625;5797.652140871562;3219.8873039443974;3263.771535992505;3271.7709760316548;3274.705276525124;3279.3933122372437;6377.617342959437;6397.904031439532;6398.104265402847;6402.231732192166;6409.391107844747;6088.4215999479975;6278.497720182374;6322.178116844872;6326.715297811609;6330.715117819617;6353.14232578596;6356.9364306357265;6357.936420635734;6379.457746091634;6400.967995159995;5880.911786323294;6096.695165241631;6107.236595425572;6129.693515324305;6138.723757430837;6029.8191054268445;6080.209572755513;6081.483073938764;6107.969460152671;6108.450239478469;6108.328083910677;6340.809775706736;6379.96810015947;6386.1480170749965;6389.520785941166;4177.624013838769;4181.344846022736;4198.370244463233;4208.263553878121;4211.936820947627;6145.9692701536205;6179;6179.84550386226;6183.505319574513;6186.81439556814;5826.73779679907;5993.460588547052;6025.87948241024;6037.09443583466;6041.697915104315;5977.923973684605;5997.520198384206;6012.368701286302;6018.458338749533;6031.215941927521;5759.56803239767;5905.287466634628;5910.881782364415;5930.762769489172;5945.732442040032;5742.397048309867;5822.563307752021;5898.528117750484;5905.202797622266;5990.550708696778;5890.823275301748;5895.380984996686;5898.970505147447;5909.468147866713;5929.466348028698 05:15:22 INFO - PROCESS | 5355 | |5;yui.html;753.0887625972573;796.1004065406092;824.212876702749;837.9622916968735;864.438115225104;13506.527271545498;13751.65620859479;13787.931060344697;13793.310334483285;13815.37830797614;13845.723085538308;14249;14277.571672849805;14280.928595357009;14295.57113286603;682.1166589266886;781.5740421470284;803.6343463724021;805.3154818404339;805.3677862877643;797.3262593108814;801.6873419366452;803.6062329458553;804.7424824056304;805.6173317674087;832.6128350317101;833.5915401453304;834.1075049696827;834.4909605140859;835.1272919798824;700.677688263402;813.8168911994813;832.5753865528563;837.0457678246803;840.1724301562956;611.9663418512025;613.3406587918006;614.0482252508593;616.1066453642237;618.2735286038886;13050.86949130506;13096.214227146307;13119.86880131196;13120.540781072712;13125.737485250242;13359.933200334033;14067.718645627132;14127.293635318192;14131.576052718436;14143.222122783243;11138.832917506244;11323.773524529546;11572.305661660328;11611.825822612667;11842.526298948032;3908.1597456546697;3910.354791459406;3948.5261768587666;4035.1324465239823;4035.9798201009103;53162.734186328824;53193.73403132998;53227.935441291345;53331.466685333035;54036.45963540354;9884.851727224097;10351.120154786777;10385.273030887765;10534.683959481228;10553.63062292816;17572.560685982953;17574.472765817045;17758.822411775975;17773.822261777474;18306.633867322846;8376.162383761575;8650.87023694645;8736.170063843925;8759.255463285564;8978.506182159914;4804.927926081112;4929.975350123226;4976.477469865612;4977.203647416469;5192.688438693615;3325.717314028286;3377.7804442711144;3387.2209391840015;3391.593008838955;3401.557797486311;539.16683276859;597.6324560395412;601.3745704467304;602.3855667219411;604.2929772166488;599.7481057955669;777.4985134588159;781.9139894611588;818.1899919080187;819.2503858969096;8934.776630584158;9316.767080823034;9334.486603236886;9494.572744226527;9755.170810481046;697.5117417807555;739.5747445219021;758.2909979169494;762.3900879296541;776.6311002273987;4546.954530454719;4647.907041859144;4680.087382960358;4700.858974230779;4730.314104454904;59224;61238.081428778605;61329.693351533846;65143.34856651373;67534;41514.169716606106;41966.37050444246;43821.561784382386;52584.47415525872;52624.47375526273;38164.99999999945;46119;47962.76018619954;48595.5140448598;49284.75357623261;8966;9221.585028673591;9258.629654813732;9285.535723213678;9485.810283794148;32510.349793003534;32941.341173175926;33233.66766332403;33403.33193336168;33534.832325838215;41530;43875.12249754923;43981.34027989647;44703.776481117384;44706.55293447024;11324;12091.637250882488;12126.514939402325;12207.145499814927;12410;13340.599782006555;13605.931970340085;13782.306955966751;13812.309384530934;13846;12952.870471295166;13266.403011864297;13447.663808404868;13771;13795.931020344835;11993.82009269879;12222.75554488923;12299.508019679113;12734.235945843278;12767.425465853874;12896.20541285225;13058.281794501394;13087.738245234852;13284.269365185008;13742.587722368346;10656.147508199481;10681.252312338062;10923.508442120283;11111.166662500507;11465.140114491613;10614.416207108374;10930.781384372109;10970.780584388427;11031.338119712844;11041.171912106463 05:15:22 INFO - PROCESS | 5355 | __end_tp_report 05:15:22 INFO - PROCESS | 5355 | __start_cc_report 05:15:22 INFO - PROCESS | 5355 | _x_x_mozilla_cycle_collect,845 05:15:22 INFO - PROCESS | 5355 | __end_cc_report 05:15:22 INFO - PROCESS | 5355 | __startTimestamp1461500122000__endTimestamp 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | ------- Summary: start ------- 05:15:22 INFO - PROCESS | 5355 | Number of tests: 6 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#0] dojo.html Cycles:165 Average:5307.38 Median:5495.18 stddev:594.46 (10.8%) stddev-sans-first:570.42 05:15:22 INFO - PROCESS | 5355 | Values: 3096.4 3140.9 3159.0 3162.3 3191.6 5276.8 5320.5 5339.0 5367.1 5415.6 5327.9 5366.7 5379.8 5388.2 5437.2 4863.1 4872.3 4882.3 4894.6 4946.5 4871.2 4887.6 4910.3 4916.8 4924.7 4798.0 4824.7 4849.6 4933.9 4946.9 4892.5 4912.7 4913.2 4922.0 4955.0 4892.7 4894.5 4897.0 4905.7 4909.2 5165.4 5215.8 5254.7 5259.1 5317.8 5710.3 5713.6 5741.9 5744.1 5746.6 5651.3 5656.2 5750.5 5765.1 5768.0 5252.8 5274.7 5276.3 5283.6 5316.0 5725.1 5729.8 5733.4 5736.0 5795.4 5477.5 5495.2 5503.2 5553.7 5642.8 5712.5 5717.2 5723.8 5730.0 5746.3 5677.2 5697.1 5697.5 5697.6 5702.6 5482.3 5681.1 5686.4 5761.3 5770.6 4326.0 4332.2 4332.5 4332.7 4363.8 3860.2 3873.1 3892.8 3921.1 3928.5 5221.7 5302.3 5358.2 5461.6 5463.1 5731.6 5732.2 5738.5 5753.0 5771.9 5409.5 5409.9 5439.3 5451.4 5451.9 4808.4 4827.0 4879.5 4904.5 4923.4 5960.8 5986.4 5990.0 5990.7 5994.8 5734.5 5765.8 5766.9 5767.5 5769.7 5737.9 5739.0 5883.0 5897.3 5943.1 5650.9 5674.7 5679.6 5684.3 5684.3 5584.4 5792.7 5794.8 5802.6 5804.0 5542.3 5601.4 5608.8 5639.3 5656.5 5509.4 5509.5 5511.1 5512.4 5516.6 5365.8 5441.4 5444.3 5453.6 5494.0 5651.9 5657.8 5661.0 5686.8 5740.9 5526.3 5528.9 5529.7 5539.3 5581.8 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#1] ext.html Cycles:180 Average:52501.06 Median:34506.65 stddev:101683.14 (294.7%) stddev-sans-first:101893.74 05:15:22 INFO - PROCESS | 5355 | Values: 606.8 637.7 650.5 656.5 661.3 34095.1 38058.8 39045.6 39143.4 39157.2 40970.6 41492.4 41640.0 41659.4 41874.4 7697.3 8444.1 8623.7 8635.6 9911.5 10040.4 10185.6 10201.1 10210.1 10214.3 10222.9 10293.6 10295.7 10311.7 10311.8 9846.0 9875.2 9878.7 9885.1 9886.2 10017.1 10128.2 10133.8 10134.4 10567.9 40981.8 41406.8 41469.4 41474.0 41487.8 3541.3 3704.9 3717.7 3940.7 4204.3 29545.0 32039.2 32416.0 32557.5 33372.5 4246.0 4262.7 4281.2 4288.1 4295.1 304475.0 306360.0 306535.5 307328.0 307421.0 35414.0 36352.5 36379.1 36428.3 59891.7 34320.3 34342.1 34428.5 34500.7 34512.7 13255.1 14140.5 14220.3 14231.2 14240.1 12085.9 12348.6 12350.3 12360.1 12376.9 8347.4 8386.6 8388.0 8424.1 8460.7 3059.8 3133.9 3234.2 3275.0 3325.1 1109.9 1130.6 1142.4 1173.6 1209.3 29862.9 30032.7 30583.5 30613.4 30729.2 1134.3 1144.9 1154.2 1180.5 1230.5 16824.7 16868.2 17100.9 17102.6 17136.2 446565.0 453231.0 453970.0 454825.0 455577.0 54573.2 56463.0 56520.0 56528.0 56672.7 1384.2 1396.9 1400.7 1419.4 1514.1 30226.0 30915.8 31305.5 31321.4 31362.2 51064.7 51204.0 51457.0 51565.2 51839.2 377219.0 380293.0 380780.0 380820.0 380946.0 25330.4 26019.2 26384.2 27828.4 28257.7 41241.8 41515.6 41683.4 41750.2 41816.2 34393.8 35076.1 35381.5 35511.3 35561.1 34702.5 34711.8 34755.5 34894.5 34920.7 36456.3 38482.6 39854.8 39928.6 39935.4 32039.8 33761.7 33990.5 34014.7 34065.3 25705.0 26129.6 26203.5 26431.2 26765.9 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#2] jquery.html Cycles:180 Average:27868.09 Median:2509.73 stddev:79160.20 (3154.1%) stddev-sans-first:79355.37 05:15:22 INFO - PROCESS | 5355 | Values: 385.8 388.6 393.3 396.6 400.1 14212.2 15101.8 17942.8 18414.2 18441.9 13893.7 17528.3 17640.6 17936.7 18521.7 5489.6 5549.8 5659.2 5663.3 5676.4 3917.2 5385.6 5567.9 5593.8 5935.9 6160.1 6167.6 6187.9 6189.6 6199.6 6086.2 6159.1 6183.2 6192.7 6198.0 5346.3 5422.3 5448.8 5461.9 5480.5 21193.2 21488.0 21811.9 22089.9 22282.8 2367.8 2432.3 2439.3 2505.9 2513.5 13411.3 13538.5 13738.0 13986.5 14345.4 1954.2 1969.5 1971.2 1979.4 2096.8 70360.3 72979.0 73372.6 74836.0 75024.6 10097.7 10232.6 10580.7 11154.3 11269.5 14216.4 14363.9 14369.2 14376.5 14435.6 7271.3 7631.2 7863.5 8089.3 8233.5 7635.5 7666.4 7774.6 7811.1 7824.3 4403.9 4459.8 4466.2 4504.5 4565.8 1831.2 1836.8 1839.5 1842.5 1843.5 984.0 1010.9 1021.4 1028.7 1075.7 17626.4 18314.0 18521.4 18698.2 18708.3 989.6 1000.5 1004.3 1009.8 1056.5 10096.9 10333.2 10348.8 10506.5 10605.5 467190.0 471281.0 484658.0 484974.0 491680.0 92814.5 96070.0 96361.0 97230.5 97284.0 995.9 1017.0 1018.8 1051.3 1052.9 16161.3 16208.7 16336.8 16403.0 16473.6 28320.6 38392.0 39597.4 40060.0 40299.6 38747.4 52098.5 52196.7 52750.7 55322.0 7606.3 7973.8 7990.8 8064.4 8065.0 6417.5 9083.5 12352.3 12464.4 12574.9 10104.3 10625.9 10704.9 11070.5 11224.3 10206.7 10632.5 10809.2 10933.8 11002.6 6711.5 8271.6 11025.2 11037.3 11213.7 7694.6 7978.9 8071.4 8095.5 8241.4 8150.0 10861.9 11424.9 11456.1 12026.1 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#3] mootools.html Cycles:180 Average:5484.05 Median:5039.47 stddev:3045.65 (60.4%) stddev-sans-first:3038.34 05:15:22 INFO - PROCESS | 5355 | Values: 1348.3 1488.4 1507.8 1639.7 1765.3 7901.9 8159.1 8183.8 8197.0 8218.6 7791.3 7899.4 7911.3 7916.7 7924.6 1996.4 2180.6 2245.4 2255.2 2295.6 2250.3 2260.1 2273.5 2277.9 2278.2 2239.6 2279.3 2285.5 2287.1 2289.8 1955.7 2176.8 2229.6 2232.0 2234.1 2104.6 2117.3 2117.9 2123.2 2182.3 8194.1 8255.0 8359.2 8378.7 8485.1 4993.2 5132.7 5135.3 5169.2 5187.9 3370.8 3404.0 3438.8 3471.3 3506.6 1117.2 1129.9 1140.4 1162.2 1177.8 11429.8 11431.9 11445.3 11463.2 11477.7 4376.2 4398.6 4524.9 4551.1 4628.7 9777.9 9808.0 9819.4 9826.4 9839.3 4597.4 5124.3 5134.2 5153.0 5156.5 4291.0 4317.8 4434.2 4540.2 4565.7 3814.7 3920.5 3930.9 3962.0 3970.7 1253.1 1263.4 1276.2 1287.3 1287.6 752.0 785.5 915.4 930.7 964.0 5486.7 5613.6 5738.7 5742.9 5744.5 963.8 1018.9 1020.4 1032.0 1045.7 3903.4 3978.4 3984.4 3989.7 4006.3 9964.3 10094.0 10269.4 10305.4 10317.5 10193.6 10202.9 10213.5 10241.7 10249.5 7449.9 7490.0 7510.1 7517.0 7530.2 5628.7 5671.2 5792.7 5835.2 5932.5 9452.6 9479.4 9630.8 9651.7 9680.3 9015.2 9464.5 9727.5 9747.0 9881.9 6396.6 6599.2 6608.7 7040.5 7167.1 7744.2 7956.3 7972.0 7998.6 8010.3 7037.3 7230.2 7245.6 7340.3 7346.8 7125.3 7150.3 7151.9 7197.5 7262.2 6774.6 6843.6 6856.2 6868.0 6870.8 4957.3 4990.7 5019.2 5059.8 5071.0 4979.0 4988.6 5013.6 5085.7 5104.2 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#4] prototype.html Cycles:180 Average:4968.58 Median:5751.92 stddev:1509.15 (26.2%) stddev-sans-first:1472.46 05:15:22 INFO - PROCESS | 5355 | Values: 318.0 319.4 325.9 330.2 331.5 5582.8 5642.8 5707.5 5738.1 5850.2 5569.2 5627.9 5645.4 5656.8 5678.1 4325.3 4330.6 4339.7 4343.5 4352.8 4081.7 4144.2 4300.5 4336.8 4340.0 4248.7 4265.3 4271.2 4277.2 4285.4 4076.5 4262.3 4281.5 4282.0 4299.8 3642.2 3746.5 3753.5 3761.7 3769.2 5406.9 5409.9 5416.8 5429.8 5459.4 4774.9 4889.8 4905.4 4914.2 4920.9 5832.2 5852.9 5869.4 5883.5 5903.8 4111.9 4113.7 4115.1 4131.5 4136.3 5892.9 6022.5 6122.7 6145.8 6188.4 4174.1 4191.9 4196.3 4200.4 4201.3 4235.6 4251.3 4254.0 4265.4 4276.6 4756.9 4918.5 4926.9 4936.8 4954.0 5900.5 5931.7 5933.8 5938.9 5969.4 1458.9 1470.4 1474.2 1476.1 1489.0 896.4 941.4 945.3 955.1 956.4 5546.4 5711.3 5718.1 5732.3 5744.3 5981.6 6035.9 6036.8 6100.1 6134.3 5670.5 5784.3 5786.2 5788.3 5797.7 3219.9 3263.8 3271.8 3274.7 3279.4 6377.6 6397.9 6398.1 6402.2 6409.4 6088.4 6278.5 6322.2 6326.7 6330.7 6353.1 6356.9 6357.9 6379.5 6401.0 5880.9 6096.7 6107.2 6129.7 6138.7 6029.8 6080.2 6081.5 6108.0 6108.5 6108.3 6340.8 6380.0 6386.1 6389.5 4177.6 4181.3 4198.4 4208.3 4211.9 6146.0 6179.0 6179.8 6183.5 6186.8 5826.7 5993.5 6025.9 6037.1 6041.7 5977.9 5997.5 6012.4 6018.5 6031.2 5759.6 5905.3 5910.9 5930.8 5945.7 5742.4 5822.6 5898.5 5905.2 5990.6 5890.8 5895.4 5899.0 5909.5 5929.5 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - PROCESS | 5355 | [#5] yui.html Cycles:180 Average:14389.33 Median:44342.56 stddev:16220.91 (36.6%) stddev-sans-first:16234.09 05:15:22 INFO - PROCESS | 5355 | Values: 753.1 796.1 824.2 838.0 864.4 13506.5 13751.7 13787.9 13793.3 13815.4 13845.7 14249.0 14277.6 14280.9 14295.6 682.1 781.6 803.6 805.3 805.4 797.3 801.7 803.6 804.7 805.6 832.6 833.6 834.1 834.5 835.1 700.7 813.8 832.6 837.0 840.2 612.0 613.3 614.0 616.1 618.3 13050.9 13096.2 13119.9 13120.5 13125.7 13359.9 14067.7 14127.3 14131.6 14143.2 11138.8 11323.8 11572.3 11611.8 11842.5 3908.2 3910.4 3948.5 4035.1 4036.0 53162.7 53193.7 53227.9 53331.5 54036.5 9884.9 10351.1 10385.3 10534.7 10553.6 17572.6 17574.5 17758.8 17773.8 18306.6 8376.2 8650.9 8736.2 8759.3 8978.5 4804.9 4930.0 4976.5 4977.2 5192.7 3325.7 3377.8 3387.2 3391.6 3401.6 539.2 597.6 601.4 602.4 604.3 599.7 777.5 781.9 818.2 819.3 8934.8 9316.8 9334.5 9494.6 9755.2 697.5 739.6 758.3 762.4 776.6 4547.0 4647.9 4680.1 4700.9 4730.3 59224.0 61238.1 61329.7 65143.3 67534.0 41514.2 41966.4 43821.6 52584.5 52624.5 38165.0 46119.0 47962.8 48595.5 49284.8 8966.0 9221.6 9258.6 9285.5 9485.8 32510.3 32941.3 33233.7 33403.3 33534.8 41530.0 43875.1 43981.3 44703.8 44706.6 11324.0 12091.6 12126.5 12207.1 12410.0 13340.6 13605.9 13782.3 13812.3 13846.0 12952.9 13266.4 13447.7 13771.0 13795.9 11993.8 12222.8 12299.5 12734.2 12767.4 12896.2 13058.3 13087.7 13284.3 13742.6 10656.1 10681.3 10923.5 11111.2 11465.1 10614.4 10930.8 10970.8 11031.3 11041.2 05:15:22 INFO - PROCESS | 5355 | -------- Summary: end -------- 05:15:22 INFO - PROCESS | 5355 | 05:15:22 INFO - TEST-INFO | 5355: exit 0 05:15:22 INFO - TEST-OK | dromaeo_css | took 1112356ms 05:15:22 INFO - TEST-START | kraken 05:15:22 INFO - operating with platform_type : linux_ 05:15:22 INFO - Initialising browser for kraken test... 05:15:22 INFO - TEST-INFO | started process 5535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMZdQAg/profile http://localhost:44533/getInfo.html) 05:15:26 INFO - PROCESS | 5535 | __metrics Screen width/height:1600/1200 05:15:26 INFO - PROCESS | 5535 | colorDepth:24 05:15:26 INFO - PROCESS | 5535 | Browser inner width/height: 1024/697 05:15:26 INFO - PROCESS | 5535 | __metrics 05:15:28 ERROR - PROCESS | 5535 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:15:28 INFO - TEST-INFO | 5535: exit 0 05:15:28 INFO - Browser initialized. 05:15:28 INFO - Running cycle 1/1 for kraken test... 05:15:28 INFO - TEST-INFO | started process 5620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMZdQAg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:40 INFO - PROCESS | 5620 | RSS: Main: 154238976 05:15:40 INFO - PROCESS | 5620 | 05:15:43 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44533/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:43 INFO - PROCESS | 5620 | RSS: Main: 209600512 05:15:43 INFO - PROCESS | 5620 | 05:15:46 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44533/tests/kraken/driver.html?testName=audio-dft) 05:15:47 INFO - PROCESS | 5620 | RSS: Main: 194924544 05:15:47 INFO - PROCESS | 5620 | 05:15:50 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44533/tests/kraken/driver.html?testName=audio-fft) 05:15:51 INFO - PROCESS | 5620 | RSS: Main: 266326016 05:15:51 INFO - PROCESS | 5620 | 05:15:53 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44533/tests/kraken/driver.html?testName=audio-oscillator) 05:15:53 INFO - PROCESS | 5620 | RSS: Main: 173309952 05:15:53 INFO - PROCESS | 5620 | 05:15:55 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:56 INFO - PROCESS | 5620 | RSS: Main: 178479104 05:15:56 INFO - PROCESS | 5620 | 05:15:59 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44533/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:00 INFO - PROCESS | 5620 | RSS: Main: 214478848 05:16:00 INFO - PROCESS | 5620 | 05:16:03 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44533/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:03 INFO - PROCESS | 5620 | RSS: Main: 214573056 05:16:03 INFO - PROCESS | 5620 | 05:16:06 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44533/tests/kraken/driver.html?testName=json-parse-financial) 05:16:07 INFO - PROCESS | 5620 | RSS: Main: 215068672 05:16:07 INFO - PROCESS | 5620 | 05:16:08 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:09 INFO - PROCESS | 5620 | RSS: Main: 203481088 05:16:09 INFO - PROCESS | 5620 | 05:16:11 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:11 INFO - PROCESS | 5620 | RSS: Main: 203915264 05:16:11 INFO - PROCESS | 5620 | 05:16:13 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:14 INFO - PROCESS | 5620 | RSS: Main: 215646208 05:16:14 INFO - PROCESS | 5620 | 05:16:17 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:17 INFO - PROCESS | 5620 | RSS: Main: 223535104 05:16:17 INFO - PROCESS | 5620 | 05:16:20 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:21 INFO - PROCESS | 5620 | RSS: Main: 219467776 05:16:21 INFO - PROCESS | 5620 | 05:16:22 INFO - PROCESS | 5620 | Cycle 1(1): loaded http://localhost:44533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44533/tests/kraken/driver.html?testName=ai-astar) 05:16:23 INFO - PROCESS | 5620 | RSS: Main: 282935296 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | __start_tp_report 05:16:23 INFO - PROCESS | 5620 | _x_x_mozilla_page_load 05:16:23 INFO - PROCESS | 5620 | _x_x_mozilla_page_load_details 05:16:23 INFO - PROCESS | 5620 | |i|pagename|runs| 05:16:23 INFO - PROCESS | 5620 | |0;ai-astar;110;111;107;110;110;111;99;110;111;109 05:16:23 INFO - PROCESS | 5620 | |1;audio-beat-detection;154;130;153;179;128;151;154;128;191;129 05:16:23 INFO - PROCESS | 5620 | |2;audio-dft;162;160;163;161;160;161;160;162;160;162 05:16:23 INFO - PROCESS | 5620 | |3;audio-fft;77;76;106;117;73;73;76;118;104;76 05:16:23 INFO - PROCESS | 5620 | |4;audio-oscillator;92;94;142;93;93;94;152;92;93;154 05:16:23 INFO - PROCESS | 5620 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 05:16:23 INFO - PROCESS | 5620 | |6;imaging-darkroom;146;146;147;146;147;146;146;150;146;147 05:16:23 INFO - PROCESS | 5620 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;94;94 05:16:23 INFO - PROCESS | 5620 | |8;json-parse-financial;58;57;56;56;56;56;59;77;53;54 05:16:23 INFO - PROCESS | 5620 | |9;json-stringify-tinderbox;60;61;60;60;61;61;61;61;61;61 05:16:23 INFO - PROCESS | 5620 | |10;stanford-crypto-aes;76;84;83;75;78;77;82;85;77;77 05:16:23 INFO - PROCESS | 5620 | |11;stanford-crypto-ccm;137;128;124;130;134;125;130;125;156;137 05:16:23 INFO - PROCESS | 5620 | |12;stanford-crypto-pbkdf2;163;162;164;168;167;161;161;172;177;164 05:16:23 INFO - PROCESS | 5620 | |13;stanford-crypto-sha256-iterative;67;69;71;67;70;67;66;67;72;70 05:16:23 INFO - PROCESS | 5620 | __end_tp_report 05:16:23 INFO - PROCESS | 5620 | __start_cc_report 05:16:23 INFO - PROCESS | 5620 | _x_x_mozilla_cycle_collect,1645 05:16:23 INFO - PROCESS | 5620 | __end_cc_report 05:16:23 INFO - PROCESS | 5620 | __startTimestamp1461500183000__endTimestamp 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | ------- Summary: start ------- 05:16:23 INFO - PROCESS | 5620 | Number of tests: 14 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.65 (3.3%) stddev-sans-first:3.84 05:16:23 INFO - PROCESS | 5620 | Values: 110.0 111.0 107.0 110.0 110.0 111.0 99.0 110.0 111.0 109.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.50 stddev:22.04 (14.4%) stddev-sans-first:23.32 05:16:23 INFO - PROCESS | 5620 | Values: 154.0 130.0 153.0 179.0 128.0 151.0 154.0 128.0 191.0 129.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 05:16:23 INFO - PROCESS | 5620 | Values: 162.0 160.0 163.0 161.0 160.0 161.0 160.0 162.0 160.0 162.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#3] audio-fft Cycles:10 Average:89.60 Median:74.50 stddev:19.14 (25.7%) stddev-sans-first:19.75 05:16:23 INFO - PROCESS | 5620 | Values: 77.0 76.0 106.0 117.0 73.0 73.0 76.0 118.0 104.0 76.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.39 (29.4%) stddev-sans-first:28.27 05:16:23 INFO - PROCESS | 5620 | Values: 92.0 94.0 142.0 93.0 93.0 94.0 152.0 92.0 93.0 154.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:16:23 INFO - PROCESS | 5620 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.25 (0.9%) stddev-sans-first:1.30 05:16:23 INFO - PROCESS | 5620 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 150.0 146.0 147.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:16:23 INFO - PROCESS | 5620 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:56.50 stddev:6.83 (12.1%) stddev-sans-first:7.24 05:16:23 INFO - PROCESS | 5620 | Values: 58.0 57.0 56.0 56.0 56.0 56.0 59.0 77.0 53.0 54.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 05:16:23 INFO - PROCESS | 5620 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:3.69 (4.6%) stddev-sans-first:3.70 05:16:23 INFO - PROCESS | 5620 | Values: 76.0 84.0 83.0 75.0 78.0 77.0 82.0 85.0 77.0 77.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.00 stddev:9.50 (7.2%) stddev-sans-first:9.94 05:16:23 INFO - PROCESS | 5620 | Values: 137.0 128.0 124.0 130.0 134.0 125.0 130.0 125.0 156.0 137.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:5.22 (3.2%) stddev-sans-first:5.43 05:16:23 INFO - PROCESS | 5620 | Values: 163.0 162.0 164.0 168.0 167.0 161.0 161.0 172.0 177.0 164.0 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - PROCESS | 5620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:2.07 (3.0%) stddev-sans-first:2.11 05:16:23 INFO - PROCESS | 5620 | Values: 67.0 69.0 71.0 67.0 70.0 67.0 66.0 67.0 72.0 70.0 05:16:23 INFO - PROCESS | 5620 | -------- Summary: end -------- 05:16:23 INFO - PROCESS | 5620 | 05:16:23 INFO - TEST-INFO | 5620: exit 0 05:16:24 INFO - TEST-OK | kraken | took 61272ms 05:16:24 INFO - SUITE-END | took 1173s 05:16:24 INFO - Completed test suite (00:19:33) 05:16:24 INFO - javascript benchmark 05:16:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.4116817804615, 3140.9371812563736, 3158.9999999999986, 3162.2726772842248, 3191.632962209346, 5276.762545685444, 5320.521153096221, 5339.038414545958, 5367.141257398817, 5415.620906536544, 5327.934413117373, 5366.677999320033, 5379.757910894009, 5388.245645609608, 5437.238786569874, 4863.124637565228, 4872.317875497433, 4882.3408839806525, 4894.632902532307, 4946.480619534951, 4871.196252618313, 4887.584555312803, 4910.263460480921, 4916.827911023115, 4924.729139897304, 4798.0, 4824.734639594821, 4849.636277279201, 4933.925991110136, 4946.901061978776, 4892.461829198785, 4912.7297998610065, 4913.1893237616105, 4921.950780492185, 4954.975225123887, 4892.706437613719, 4894.535019173173, 4896.951030489685, 4905.730184839832, 4909.165441874889, 5165.405978312505, 5215.8174463893965, 5254.710990895499, 5259.105951988171, 5317.760700768475, 5710.343310519302, 5713.6000479966415, 5741.913871291934, 5744.138379243105, 5746.569007324468, 5651.2935883014625, 5656.179853921159, 5750.482456578928, 5765.077587586008, 5768.048272035109, 5252.842414727565, 5274.683518988873, 5276.287701160371, 5283.577313814885, 5315.973420132913, 5725.055365864586, 5729.799457018984, 5733.426657334317, 5736.0, 5795.391483894215, 5477.507024367826, 5495.175723641406, 5503.229547863302, 5553.666779993133, 5642.774289028475, 5712.485876271156, 5717.2281741965135, 5723.7996670116345, 5730.0, 5746.310442746813, 5677.1768093627015, 5697.145428185805, 5697.515711164598, 5697.601167918288, 5702.600817942704, 5482.259894914136, 5681.147827825859, 5686.43135686428, 5761.251037365116, 5770.596058275881, 4326.048269380732, 4332.241857674894, 4332.501762297313, 4332.696711230184, 4363.781810909441, 3860.1507668312925, 3873.128860043956, 3892.82482288292, 3921.058945852975, 3928.548216955087, 5221.7128057956415, 5302.284191634157, 5358.2498450217, 5461.563074954073, 5463.098588732814, 5731.598788084794, 5732.197492351074, 5738.540916726652, 5752.9712351437975, 5771.913421298684, 5409.540189083893, 5409.891802163935, 5439.292891924025, 5451.427600102012, 5451.863703407367, 4808.3989501312335, 4827.034593081397, 4879.536444037811, 4904.5340692634145, 4923.384576927884, 5960.821175364746, 5986.3714309997695, 5990.041593345044, 5990.700464976734, 5994.7602095916545, 5734.5125664319, 5765.798197063083, 5766.8846623066465, 5767.5385969121535, 5769.711514424178, 5737.8565535861935, 5739.0, 5883.0293001654245, 5897.292324921037, 5943.078822782476, 5650.85872853182, 5674.659520428788, 5679.574031947703, 5684.261046063985, 5684.346300175367, 5584.441555844383, 5792.652440853562, 5794.768209271582, 5802.593818432669, 5804.013317736079, 5542.2795036644975, 5601.439856014366, 5608.803691870765, 5639.3232812062815, 5656.490915817596, 5509.449055094618, 5509.5041446270025, 5511.090670039559, 5512.39363670004, 5516.558675306046, 5365.839024829262, 5441.428649991693, 5444.3194600674915, 5453.590980676545, 5494.0, 5651.915221271602, 5657.830265092054, 5660.971695141498, 5686.772529098956, 5740.913886291625, 5526.336839579276, 5528.889422211453, 5529.695866727368, 5539.307586551681, 5581.832545023656], "value": 5268.014433689223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.766394937949, 637.735339833969, 650.5381179362653, 656.5043392238862, 661.2792056658242, 34095.14762130945, 38058.80970595147, 39045.60954390455, 39143.41284880729, 39157.21685566294, 40970.59029409705, 41492.37761433573, 41640.0, 41659.37510937338, 41874.37188442176, 7697.34572561333, 8444.113368096354, 8623.65505379784, 8635.568221588896, 9911.454869982148, 10040.447775372351, 10185.643502477415, 10201.081902628763, 10210.081092701656, 10214.336068155584, 10222.897771022306, 10293.588256469733, 10295.691129266097, 10311.690649280534, 10311.84532232017, 9846.0, 9875.160611348045, 9878.654247101389, 9885.110340069356, 9886.209103271722, 10017.098461138532, 10128.240381971382, 10133.847992280122, 10134.442605656686, 10567.894321056845, 40981.79509102435, 41406.79296603498, 41469.37795933063, 41474.0, 41487.792561037, 3541.3094446582927, 3704.944425833615, 3717.70258379329, 3940.704447166474, 4204.285271503852, 29545.0, 32039.199020024455, 32416.0, 32557.511637325224, 33372.499412508834, 4246.0, 4262.658987281041, 4281.229378711831, 4288.099499105192, 4295.076558539898, 304475.0, 306360.0, 306535.46732266416, 307328.0, 307421.0, 35414.0, 36352.45471317879, 36379.09052273662, 36428.27143457116, 59891.70054149701, 34320.31359372799, 34342.14144646354, 34428.48357274643, 34500.65499345025, 34512.65487345144, 13255.072144949761, 14140.50508232207, 14220.288985550887, 14231.217283049531, 14240.074395164282, 12085.939570302093, 12348.567800126952, 12350.258984460961, 12360.134790564754, 12376.938115309365, 8347.373946954003, 8386.622601982803, 8387.958060209781, 8424.115467875907, 8460.746177614681, 3059.831709255968, 3133.8903138390046, 3234.207619133327, 3274.9672503274664, 3325.118843506473, 1109.9455517258637, 1130.621241883978, 1142.3945308986251, 1173.5892437646755, 1209.2986068080493, 29862.850685746867, 30032.699673003426, 30583.541246881316, 30613.38773224523, 30729.231769205948, 1134.2570616246371, 1144.9141314401286, 1154.1516985016005, 1180.451090243041, 1230.5262473947594, 16824.663506729798, 16868.24092915822, 17100.91449542744, 17102.57243568896, 17136.22886970089, 446565.0, 453231.0, 453970.0, 454825.0, 455577.0, 54573.181402279, 56463.0, 56520.0, 56528.0, 56672.71663641655, 1384.210999730144, 1396.8952328575397, 1400.6848459096623, 1419.4038503828417, 1514.136941943104, 30226.0, 30915.845420772752, 31305.53041704331, 31321.37357252888, 31362.21594460157, 51064.74467627638, 51204.0, 51457.0, 51565.22652160146, 51839.222411663104, 377219.0, 380293.0, 380780.0, 380820.0, 380946.0, 25330.36674083089, 26019.21942341733, 26384.20847374505, 27828.44343113167, 28257.71742282551, 41241.793791030854, 41515.58484415117, 41683.37474937939, 41750.16499670051, 41816.1636767269, 34393.82803085969, 35076.12309692278, 35381.469277960336, 35511.28977420489, 35561.1109722259, 34702.47946280858, 34711.785087521814, 34755.478667819494, 34894.476582850766, 34920.65079349174, 36456.27087458183, 38482.6151738479, 39854.800725997346, 39928.60071399249, 39935.400968984904, 32039.83980080178, 33761.66238337585, 33990.49014264739, 34014.65985340214, 34065.31869362549, 25705.0, 26129.60805587956, 26203.475930481665, 26431.20706378812, 26765.86617066902], "value": 18310.544788815878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.76853887667386, 388.60944750525715, 393.3146467387246, 396.5518963571165, 400.13770324949724, 14212.218327991955, 15101.848981510182, 17942.820571794276, 18414.17136228871, 18441.907790461046, 13893.722125557482, 17528.29886804526, 17640.647187056253, 17936.730949035777, 18521.722174167397, 5489.64317319375, 5549.833504994836, 5659.236003139565, 5663.348714897798, 5676.432356764331, 3917.2165566886592, 5385.649932754378, 5567.8608034799045, 5593.804216852411, 5935.85160370992, 6160.1375807387, 6167.568270221086, 6187.938120618804, 6189.628622282655, 6199.628022318675, 6086.239220097488, 6159.076138579204, 6183.165272688175, 6192.721327540272, 6197.969010154966, 5346.251524786533, 5422.267993820863, 5448.8365349039195, 5461.890762184774, 5480.479354461319, 21193.152273909025, 21488.0, 21811.890940545356, 22089.889550552307, 22282.777172228234, 2367.786899179082, 2432.2824766693866, 2439.329184474266, 2505.922453345061, 2513.5349960257413, 13411.329433528284, 13538.458461661521, 13738.0, 13986.510472133426, 14345.426182952773, 1954.1890115602007, 1969.5076230942263, 1971.2312198242696, 1979.4160722586728, 2096.7693553709078, 70360.29639703639, 72979.0, 73372.63313683397, 74836.0, 75024.62487687527, 10097.697069087939, 10232.64185753495, 10580.682579522627, 11154.330740155616, 11269.54921803135, 14216.360263788154, 14363.856361436252, 14369.209693466959, 14376.496822611367, 14435.566932992027, 7271.309225623558, 7631.236876312324, 7863.528188308605, 8089.31240844523, 8233.46482478649, 7635.465517413728, 7666.386689064973, 7774.572398518023, 7811.140774514799, 7824.334931530883, 4403.933940990888, 4459.799309031101, 4466.151431228056, 4504.504504504502, 4565.817367305337, 1831.2400353853268, 1836.779586449608, 1839.4849442156217, 1842.5218081680118, 1843.4653950354248, 983.9704808855746, 1010.8534262532039, 1021.382063851374, 1028.7222449938624, 1075.7471994081384, 17626.383076592516, 18314.0, 18521.35175268859, 18698.158582863805, 18708.345207917657, 989.5547003848297, 1000.5347513406301, 1004.317064396203, 1009.7526106104051, 1056.529844219315, 10096.899031009743, 10333.22500812442, 10348.793024139475, 10506.474676266309, 10605.522751476203, 467190.0, 471281.0, 484658.0, 484974.0, 491680.0, 92814.53592732128, 96070.0, 96361.0, 97230.51384743172, 97284.0, 995.9452230127413, 1017.0287375556474, 1018.8471729240673, 1051.2903789941759, 1052.8526006359116, 16161.27274272684, 16208.67582648364, 16336.754948676016, 16403.0, 16473.588160296087, 28320.575191372558, 38392.04019899525, 39597.40603891001, 40060.0, 40299.59700402959, 38747.41878871876, 52098.47901520936, 52196.73901630467, 52750.73624631852, 55322.0, 7606.315431611181, 7973.80065498344, 7990.760277191694, 8064.435489515912, 8065.0, 6417.518686098468, 9083.45499270046, 12352.320622365856, 12464.376781160725, 12574.87425125737, 10104.292699510963, 10625.9468702656, 10704.946475267885, 11070.501827417624, 11224.270422422516, 10206.693799186036, 10632.468376580986, 10809.243352965217, 10933.781324373309, 11002.634433596815, 6711.4966377520905, 8271.62777674994, 11025.228234023862, 11037.337759734442, 11213.738779264153, 7694.615269236404, 7978.880316795136, 8071.354291656771, 8095.514269143635, 8241.381896357678, 8150.021997360354, 10861.930014825077, 11424.885751142714, 11456.140789440658, 12026.098042646661], "value": 8867.849279850881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.2719331560957, 1488.4269556220854, 1507.8416766239545, 1639.6966561186182, 1765.2938824470211, 7901.881471777928, 8159.10249872515, 8183.754487365373, 8196.959015204931, 8218.589070546479, 7791.259830316125, 7899.407544434176, 7911.327537159334, 7916.6833326666865, 7924.603769811501, 1996.3711430899293, 2180.6292930201826, 2245.4498647831265, 2255.1994042115057, 2295.5523672883796, 2250.2799104286637, 2260.1298500077505, 2273.4884650953486, 2277.886105694717, 2278.236790675126, 2239.596872562938, 2279.327598358488, 2285.5200407914276, 2287.1194590082855, 2289.7939185473306, 1955.6577598920203, 2176.8027584828283, 2229.55408918217, 2232.0290673557056, 2234.084025549533, 2104.5685634444903, 2117.269542008005, 2117.9046942887608, 2123.182574708733, 2182.3125715399756, 8194.09864914859, 8254.958725206336, 8359.164083591591, 8378.706745263886, 8485.109063548362, 4993.151164302078, 5132.666376685504, 5135.332406787131, 5169.224616307546, 5187.870303242411, 3370.831458427069, 3403.9829800851085, 3438.7592868499214, 3471.3230919970615, 3506.561679790026, 1117.1956191542076, 1129.9096072314196, 1140.41838662282, 1162.2096974057638, 1177.7526719388939, 11429.828552571718, 11431.885681143165, 11445.25605835618, 11463.197576169672, 11477.655670329903, 4376.168527979674, 4398.626116780046, 4524.864254072383, 4551.06703125865, 4628.74541900192, 9777.853332200022, 9808.0, 9819.41083534976, 9826.361286516354, 9839.262055345878, 4597.42532183477, 5124.282600435942, 5134.178531434953, 5153.0, 5156.510131537498, 4291.03451723366, 4317.848875289413, 4434.157510073076, 4540.182767101887, 4565.748883811356, 3814.732968692165, 3920.4903362562686, 3930.9017274568364, 3961.9801900990888, 3970.662493688011, 1253.11029169289, 1263.406199086428, 1276.1577358943052, 1287.2598256002836, 1287.6265882893856, 751.9548827070394, 785.4815821557744, 915.3729695158837, 930.734740598926, 964.0167029629738, 5486.725663716878, 5613.635113717595, 5738.68437235956, 5742.885142297131, 5744.540436765049, 963.8024205038091, 1018.9032041956002, 1020.413262374123, 1031.9896801032044, 1045.6706137566794, 3903.4144878268485, 3978.4430179774854, 3984.402339649018, 3989.6808255340084, 4006.3189257825657, 9964.302498825013, 10094.0, 10269.435181065113, 10305.381677099398, 10317.48412579368, 10193.592256309665, 10202.897971020195, 10213.489325533694, 10241.74395640115, 10249.487525623688, 7449.88825167623, 7489.962550187323, 7510.098788145458, 7517.0, 7530.209328020588, 5628.718564071862, 5671.177679236405, 5792.739326730223, 5835.153902684172, 5932.4957378621575, 9452.574634141618, 9479.383840050376, 9630.807383852143, 9651.662191823252, 9680.27397945143, 9015.188633023059, 9464.526773661428, 9727.513624318897, 9746.976567460599, 9881.851772223567, 6396.552241343062, 6599.175103112111, 6608.669566521751, 7040.507164498641, 7167.104111986002, 7744.186860379579, 7956.283934445928, 7971.960140199262, 7998.640061197377, 8010.319122874621, 7037.296270372922, 7230.240824713329, 7245.637718113968, 7340.265973402617, 7346.77959661211, 7125.251848555827, 7150.284971502808, 7151.8569628608175, 7197.470996868518, 7262.237465066303, 6774.593524388552, 6843.623600702009, 6856.24581296047, 6867.965660171667, 6870.828229294308, 4957.281194226889, 4990.6506544541535, 5019.171836646912, 5059.772310245974, 5071.011152825164, 4978.975105124451, 4988.575971042502, 5013.573846223112, 5085.7457127144235, 5104.234364845154], "value": 4435.607273842286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9904602861914, 319.3772144318579, 325.90385836178325, 330.1827975759993, 331.4577192930225, 5582.8325150245555, 5642.774289028439, 5707.543396528273, 5738.139279108136, 5850.239468869041, 5569.164625306206, 5627.859303517414, 5645.407232240617, 5656.802011929583, 5678.063119585264, 4325.307950727884, 4330.5669433056755, 4339.739615623057, 4343.543927887574, 4352.7605981670995, 4081.7346872453345, 4144.191882582898, 4300.462442194726, 4336.783160841961, 4339.956600434002, 4248.745075295476, 4265.253580623394, 4271.231178387889, 4277.165952639237, 4285.378620100084, 4076.4700588923547, 4262.339337402707, 4281.473930381059, 4282.0, 4299.849505267332, 3642.1623026704005, 3746.5316835395574, 3753.530808648919, 3761.6614504694435, 3769.208466222097, 5406.91889621656, 5409.9459005409835, 5416.837494875121, 5429.782808687648, 5459.3994660587305, 4774.880627984294, 4889.804407823683, 4905.3623029006, 4914.216053638714, 4920.876978075541, 5832.2418085649015, 5852.853678658025, 5869.383714709979, 5883.52931765462, 5903.822885313448, 4111.876643700693, 4113.691473139526, 4115.074108325633, 4131.462909821704, 4136.276151673475, 5892.941070589325, 6022.548308876808, 6122.693865306762, 6145.754169833202, 6188.350223226586, 4174.08170202555, 4191.91616167675, 4196.307609244502, 4200.390943313202, 4201.34879093741, 4235.597618226264, 4251.29853574163, 4253.97873010633, 4265.424167737316, 4276.550962148992, 4756.881077973078, 4918.458969513351, 4926.852194434173, 4936.777844996984, 4953.975230123826, 5900.524868782804, 5931.716289228678, 5933.821985340447, 5938.940610593925, 5969.432903874212, 1458.941642334316, 1470.3824393754649, 1474.2481334519473, 1476.1069552920328, 1488.9553313400615, 896.4397251717677, 941.4304345870787, 945.2579724915907, 955.0544960489066, 956.4404823178379, 5546.362168350611, 5711.314642242957, 5718.142278658234, 5732.312122545238, 5744.281964754406, 5981.641101533834, 6035.853187894286, 6036.849078772978, 6100.145979562864, 6134.263888333339, 5670.489655930904, 5784.293633378164, 5786.189933409326, 5788.305403351625, 5797.652140871562, 3219.8873039443974, 3263.771535992505, 3271.7709760316548, 3274.705276525124, 3279.3933122372437, 6377.617342959437, 6397.904031439532, 6398.104265402847, 6402.231732192166, 6409.391107844747, 6088.4215999479975, 6278.497720182374, 6322.178116844872, 6326.715297811609, 6330.715117819617, 6353.14232578596, 6356.9364306357265, 6357.936420635734, 6379.457746091634, 6400.967995159995, 5880.911786323294, 6096.695165241631, 6107.236595425572, 6129.693515324305, 6138.723757430837, 6029.8191054268445, 6080.209572755513, 6081.483073938764, 6107.969460152671, 6108.450239478469, 6108.328083910677, 6340.809775706736, 6379.96810015947, 6386.1480170749965, 6389.520785941166, 4177.624013838769, 4181.344846022736, 4198.370244463233, 4208.263553878121, 4211.936820947627, 6145.9692701536205, 6179.0, 6179.84550386226, 6183.505319574513, 6186.81439556814, 5826.73779679907, 5993.460588547052, 6025.87948241024, 6037.09443583466, 6041.697915104315, 5977.923973684605, 5997.520198384206, 6012.368701286302, 6018.458338749533, 6031.215941927521, 5759.56803239767, 5905.287466634628, 5910.881782364415, 5930.762769489172, 5945.732442040032, 5742.397048309867, 5822.563307752021, 5898.528117750484, 5905.202797622266, 5990.550708696778, 5890.823275301748, 5895.380984996686, 5898.970505147447, 5909.468147866713, 5929.466348028698], "value": 4474.744317309909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.0887625972573, 796.1004065406092, 824.212876702749, 837.9622916968735, 864.438115225104, 13506.527271545498, 13751.65620859479, 13787.931060344697, 13793.310334483285, 13815.37830797614, 13845.723085538308, 14249.0, 14277.571672849805, 14280.928595357009, 14295.57113286603, 682.1166589266886, 781.5740421470284, 803.6343463724021, 805.3154818404339, 805.3677862877643, 797.3262593108814, 801.6873419366452, 803.6062329458553, 804.7424824056304, 805.6173317674087, 832.6128350317101, 833.5915401453304, 834.1075049696827, 834.4909605140859, 835.1272919798824, 700.677688263402, 813.8168911994813, 832.5753865528563, 837.0457678246803, 840.1724301562956, 611.9663418512025, 613.3406587918006, 614.0482252508593, 616.1066453642237, 618.2735286038886, 13050.86949130506, 13096.214227146307, 13119.86880131196, 13120.540781072712, 13125.737485250242, 13359.933200334033, 14067.718645627132, 14127.293635318192, 14131.576052718436, 14143.222122783243, 11138.832917506244, 11323.773524529546, 11572.305661660328, 11611.825822612667, 11842.526298948032, 3908.1597456546697, 3910.354791459406, 3948.5261768587666, 4035.1324465239823, 4035.9798201009103, 53162.734186328824, 53193.73403132998, 53227.935441291345, 53331.466685333035, 54036.45963540354, 9884.851727224097, 10351.120154786777, 10385.273030887765, 10534.683959481228, 10553.63062292816, 17572.560685982953, 17574.472765817045, 17758.822411775975, 17773.822261777474, 18306.633867322846, 8376.162383761575, 8650.87023694645, 8736.170063843925, 8759.255463285564, 8978.506182159914, 4804.927926081112, 4929.975350123226, 4976.477469865612, 4977.203647416469, 5192.688438693615, 3325.717314028286, 3377.7804442711144, 3387.2209391840015, 3391.593008838955, 3401.557797486311, 539.16683276859, 597.6324560395412, 601.3745704467304, 602.3855667219411, 604.2929772166488, 599.7481057955669, 777.4985134588159, 781.9139894611588, 818.1899919080187, 819.2503858969096, 8934.776630584158, 9316.767080823034, 9334.486603236886, 9494.572744226527, 9755.170810481046, 697.5117417807555, 739.5747445219021, 758.2909979169494, 762.3900879296541, 776.6311002273987, 4546.954530454719, 4647.907041859144, 4680.087382960358, 4700.858974230779, 4730.314104454904, 59224.0, 61238.081428778605, 61329.693351533846, 65143.34856651373, 67534.0, 41514.169716606106, 41966.37050444246, 43821.561784382386, 52584.47415525872, 52624.47375526273, 38164.99999999945, 46119.0, 47962.76018619954, 48595.5140448598, 49284.75357623261, 8966.0, 9221.585028673591, 9258.629654813732, 9285.535723213678, 9485.810283794148, 32510.349793003534, 32941.341173175926, 33233.66766332403, 33403.33193336168, 33534.832325838215, 41530.0, 43875.12249754923, 43981.34027989647, 44703.776481117384, 44706.55293447024, 11324.0, 12091.637250882488, 12126.514939402325, 12207.145499814927, 12410.0, 13340.599782006555, 13605.931970340085, 13782.306955966751, 13812.309384530934, 13846.0, 12952.870471295166, 13266.403011864297, 13447.663808404868, 13771.0, 13795.931020344835, 11993.82009269879, 12222.75554488923, 12299.508019679113, 12734.235945843278, 12767.425465853874, 12896.20541285225, 13058.281794501394, 13087.738245234852, 13284.269365185008, 13742.587722368346, 10656.147508199481, 10681.252312338062, 10923.508442120283, 11111.166662500507, 11465.140114491613, 10614.416207108374, 10930.781384372109, 10970.780584388427, 11031.338119712844, 11041.171912106463], "value": 6705.444554415055, "unit": "score"}], "name": "dromaeo_css", "value": 6961.871389069343, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 107.0, 110.0, 110.0, 111.0, 99.0, 110.0, 111.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 153.0, 179.0, 128.0, 151.0, 154.0, 128.0, 191.0, 129.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 161.0, 160.0, 161.0, 160.0, 162.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 106.0, 117.0, 73.0, 73.0, 76.0, 118.0, 104.0, 76.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 142.0, 93.0, 93.0, 94.0, 152.0, 92.0, 93.0, 154.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 150.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 56.0, 56.0, 56.0, 59.0, 77.0, 53.0, 54.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 83.0, 75.0, 78.0, 77.0, 82.0, 85.0, 77.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 124.0, 130.0, 134.0, 125.0, 130.0, 125.0, 156.0, 137.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 168.0, 167.0, 161.0, 161.0, 172.0, 177.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 67.0, 70.0, 67.0, 66.0, 67.0, 72.0, 70.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1542.9, "alertThreshold": 2.0}]} 05:16:24 INFO - Return code: 0 05:16:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:24 ERROR - # TBPL SUCCESS # 05:16:24 INFO - Running post-action listener: _resource_record_post_action 05:16:24 INFO - Running post-run listener: _resource_record_post_run 05:16:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534601728; Read time: 168; Write time: 498352 05:16:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250638336; Read time: 0; Write time: 275668 05:16:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283963392; Read time: 168; Write time: 222684 05:16:25 INFO - Running post-run listener: _upload_blobber_files 05:16:25 INFO - Blob upload gear active. 05:16:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:25 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 05:16:25 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:16:25 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:26 INFO - (blobuploader) - INFO - Done attempting. 05:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:27 INFO - (blobuploader) - INFO - Done attempting. 05:16:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:27 INFO - Return code: 0 05:16:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df141d5b03a3062ed06852f6eb662c8e6f44abd9717f8257b7ef3722aa6a8ed10fbb46dc28feb5caa787862e3115aa2f74a0304423cd48ffe7a7173ef3a15e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba1959d4257fc58a8140a8f5336426a476a2ead95a316ffcb81d3554f2db4d92d91f555b76bc64448caa1aaac9440a140ca2f6182a58444ff317830cc6009500"} 05:16:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:27 INFO - Contents: 05:16:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df141d5b03a3062ed06852f6eb662c8e6f44abd9717f8257b7ef3722aa6a8ed10fbb46dc28feb5caa787862e3115aa2f74a0304423cd48ffe7a7173ef3a15e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba1959d4257fc58a8140a8f5336426a476a2ead95a316ffcb81d3554f2db4d92d91f555b76bc64448caa1aaac9440a140ca2f6182a58444ff317830cc6009500"} 05:16:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:27 INFO - Copying logs to upload dir... 05:16:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.371942 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-24 05:16:27.117823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 05:16:27.121322) ========= 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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 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/sha512/df141d5b03a3062ed06852f6eb662c8e6f44abd9717f8257b7ef3722aa6a8ed10fbb46dc28feb5caa787862e3115aa2f74a0304423cd48ffe7a7173ef3a15e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba1959d4257fc58a8140a8f5336426a476a2ead95a316ffcb81d3554f2db4d92d91f555b76bc64448caa1aaac9440a140ca2f6182a58444ff317830cc6009500"} build_url:https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/cz3ruuW2RrGfSYg26SGzIg/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/sha512/df141d5b03a3062ed06852f6eb662c8e6f44abd9717f8257b7ef3722aa6a8ed10fbb46dc28feb5caa787862e3115aa2f74a0304423cd48ffe7a7173ef3a15e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba1959d4257fc58a8140a8f5336426a476a2ead95a316ffcb81d3554f2db4d92d91f555b76bc64448caa1aaac9440a140ca2f6182a58444ff317830cc6009500"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 05:16:27.145200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:16:27.145498) ========= 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=d2a8c569965ab8367867b893000001a1-1461488770.775658-21447094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:16:27.228682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 05:16:27.229038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 05:16:27.229307) ========= ========= Total master_lag: 0.16 =========