builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1461586873.32 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.324614) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.325071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.325353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.341799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.342110) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 05:21:13-- 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% 222M=0s 2016-04-25 05:21:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.476414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.476773) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014020 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.528726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:13.529377) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --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 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 05:21:13,865 truncating revision to first 12 chars 2016-04-25 05:21:13,865 Setting DEBUG logging. 2016-04-25 05:21:13,865 attempt 1/10 2016-04-25 05:21:13,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:21:14,132 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567867 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:14.111725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:14.112289) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:14.113002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:14.113471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:14.123898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-25 05:21:14.124260) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:14 INFO - MultiFileLogger online at 20160425 05:21:14 in /builds/slave/test 05:21:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:21:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:14 INFO - {'append_to_log': False, 05:21:14 INFO - 'base_work_dir': '/builds/slave/test', 05:21:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:14 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:14 INFO - 'config_files': ('talos/linux_config.py',), 05:21:14 INFO - 'default_actions': ('clobber', 05:21:14 INFO - 'read-buildbot-config', 05:21:14 INFO - 'download-and-extract', 05:21:14 INFO - 'populate-webroot', 05:21:14 INFO - 'create-virtualenv', 05:21:14 INFO - 'install', 05:21:14 INFO - 'run-tests'), 05:21:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:14 INFO - 'download_minidump_stackwalk': True, 05:21:14 INFO - 'download_symbols': 'ondemand', 05:21:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:14 INFO - 'installer_path': 'installer.exe', 05:21:14 INFO - 'log_level': 'info', 05:21:14 INFO - 'log_name': 'talos', 05:21:14 INFO - 'log_to_console': True, 05:21:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:14 INFO - 'opt_config_files': (), 05:21:14 INFO - 'pip_index': False, 05:21:14 INFO - 'sps_profile': False, 05:21:14 INFO - 'sps_profile_interval': 0, 05:21:14 INFO - 'suite': 'dromaeojs', 05:21:14 INFO - 'system_bits': '32', 05:21:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:14 INFO - 'title': 'talos-linux64-ix-003', 05:21:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:14 INFO - 'use_talos_json': True, 05:21:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:14 INFO - 'work_dir': 'build'} 05:21:14 INFO - ##### 05:21:14 INFO - ##### Running clobber step. 05:21:14 INFO - ##### 05:21:14 INFO - Running pre-action listener: _resource_record_pre_action 05:21:14 INFO - Running main action method: clobber 05:21:14 INFO - rmtree: /builds/slave/test/build 05:21:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:15 INFO - Running post-action listener: _resource_record_post_action 05:21:15 INFO - ##### 05:21:15 INFO - ##### Running read-buildbot-config step. 05:21:15 INFO - ##### 05:21:15 INFO - Running pre-action listener: _resource_record_pre_action 05:21:15 INFO - Running main action method: read_buildbot_config 05:21:15 INFO - Using buildbot properties: 05:21:15 INFO - { 05:21:15 INFO - "project": "", 05:21:15 INFO - "product": "firefox", 05:21:15 INFO - "script_repo_revision": "production", 05:21:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:15 INFO - "repository": "", 05:21:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:21:15 INFO - "buildid": "20160422035423", 05:21:15 INFO - "pgo_build": "False", 05:21:15 INFO - "basedir": "/builds/slave/test", 05:21:15 INFO - "buildnumber": 1707, 05:21:15 INFO - "slavename": "talos-linux64-ix-003", 05:21:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:21:15 INFO - "platform": "ubuntu64_hw", 05:21:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:15 INFO - "branch": "fx-team", 05:21:15 INFO - "repo_path": "integration/fx-team", 05:21:15 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:21:15 INFO - "stage_platform": "linux64", 05:21:15 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:21:15 INFO - "slavebuilddir": "test" 05:21:15 INFO - } 05:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:21:15 INFO - Running post-action listener: _resource_record_post_action 05:21:15 INFO - ##### 05:21:15 INFO - ##### Running download-and-extract step. 05:21:15 INFO - ##### 05:21:15 INFO - Running pre-action listener: _resource_record_pre_action 05:21:15 INFO - Running main action method: download_and_extract 05:21:15 INFO - mkdir: /builds/slave/test/build/tests 05:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:15 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:16 INFO - Downloaded 1361 bytes. 05:21:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:21:16 INFO - Using the following test package requirements: 05:21:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'jsshell-linux-x86_64.zip'], 05:21:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21: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')]} 05:21:16 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:17 INFO - Downloaded 22281373 bytes. 05:21:17 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'] 05:21:17 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 05:21:18 INFO - Return code: 0 05:21:18 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 05:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:18 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:20 INFO - Downloaded 22281373 bytes. 05:21:20 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'] 05:21:20 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 05:21:22 INFO - Return code: 0 05:21: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')]} 05:21:22 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:23 INFO - Downloaded 10845952 bytes. 05:21:23 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'] 05:21:23 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 05:21:23 INFO - Return code: 0 05:21:23 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')]} 05:21:23 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:21:25 INFO - Downloaded 54649298 bytes. 05:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:21:25 INFO - mkdir: /builds/slave/test/properties 05:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:25 INFO - Contents: 05:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - Running post-action listener: set_extra_try_arguments 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running populate-webroot step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: populate_webroot 05:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:26 INFO - '--tppagecycles', 05:21:26 INFO - '7'], 05:21:26 INFO - 'tests': ['tsvgm']}}, 05:21:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['damp', 'tps']}, 05:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['damp', 'tps']}, 05:21:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['dromaeo_dom']}, 05:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tsvgx', 05:21:26 INFO - 'tsvgr_opacity', 05:21:26 INFO - 'tart', 05:21:26 INFO - 'tscrollx', 05:21:26 INFO - 'cart']}, 05:21:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:26 INFO - 'tsvgr_opacity', 05:21:26 INFO - 'tart', 05:21:26 INFO - 'tscrollx', 05:21:26 INFO - 'cart']}, 05:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tp5o']}, 05:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['tp5o']}, 05:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s', 05:21:26 INFO - '--xperf_path', 05:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:26 INFO - 'tests': ['tp5n']}, 05:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--xperf_path', 05:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:26 INFO - 'tests': ['tp5n']}}, 05:21:26 INFO - 'talos.zip': {'path': '', 05:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running create-virtualenv step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: create_virtualenv 05:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:26 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 05:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:26 INFO - Using real prefix '/usr' 05:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:29 INFO - Installing pip.................done. 05:21:29 INFO - Return code: 0 05:21:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21: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', 'pip>=1.5'] in /builds/slave/test/build 05:21: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 pip>=1.5 05:21:29 INFO - Using env: {'DISPLAY': ':0', 05:21:29 INFO - 'HOME': '/home/cltbld', 05:21:29 INFO - 'LANG': 'en_US.UTF-8', 05:21:29 INFO - 'LANGUAGE': 'en_US:en', 05:21:29 INFO - 'LOGNAME': 'cltbld', 05:21:29 INFO - 'MAIL': '/var/mail/cltbld', 05:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:29 INFO - 'MOZ_NO_REMOTE': '1', 05:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:29 INFO - 'NO_EM_RESTART': '1', 05:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:29 INFO - 'PWD': '/builds/slave/test', 05:21:29 INFO - 'SHELL': '/bin/bash', 05:21:29 INFO - 'SHLVL': '1', 05:21:29 INFO - 'TERM': 'linux', 05:21:29 INFO - 'TMOUT': '86400', 05:21:29 INFO - 'USER': 'cltbld', 05:21:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:29 INFO - '_': '/tools/buildbot/bin/python'} 05:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:29 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 05:21:29 INFO - Cleaning up... 05:21:29 INFO - Return code: 0 05:21:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', '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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:21: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 psutil>=0.7.1 05:21:29 INFO - Using env: {'DISPLAY': ':0', 05:21:29 INFO - 'HOME': '/home/cltbld', 05:21:29 INFO - 'LANG': 'en_US.UTF-8', 05:21:29 INFO - 'LANGUAGE': 'en_US:en', 05:21:29 INFO - 'LOGNAME': 'cltbld', 05:21:29 INFO - 'MAIL': '/var/mail/cltbld', 05:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:29 INFO - 'MOZ_NO_REMOTE': '1', 05:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:29 INFO - 'NO_EM_RESTART': '1', 05:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:29 INFO - 'PWD': '/builds/slave/test', 05:21:29 INFO - 'SHELL': '/bin/bash', 05:21:29 INFO - 'SHLVL': '1', 05:21:29 INFO - 'TERM': 'linux', 05:21:29 INFO - 'TMOUT': '86400', 05:21:29 INFO - 'USER': 'cltbld', 05:21:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:29 INFO - '_': '/tools/buildbot/bin/python'} 05:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:29 INFO - Downloading/unpacking psutil>=0.7.1 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:31 INFO - Installing collected packages: psutil 05:21:31 INFO - Running setup.py install for psutil 05:21:31 INFO - building 'psutil._psutil_linux' extension 05:21:31 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 05:21:31 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 05:21:31 INFO - building 'psutil._psutil_posix' extension 05:21:31 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 05:21:32 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 05:21:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:32 INFO - Successfully installed psutil 05:21:32 INFO - Cleaning up... 05:21:32 INFO - Return code: 0 05:21:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:21:32 INFO - Using env: {'DISPLAY': ':0', 05:21:32 INFO - 'HOME': '/home/cltbld', 05:21:32 INFO - 'LANG': 'en_US.UTF-8', 05:21:32 INFO - 'LANGUAGE': 'en_US:en', 05:21:32 INFO - 'LOGNAME': 'cltbld', 05:21:32 INFO - 'MAIL': '/var/mail/cltbld', 05:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:32 INFO - 'MOZ_NO_REMOTE': '1', 05:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:32 INFO - 'NO_EM_RESTART': '1', 05:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:32 INFO - 'PWD': '/builds/slave/test', 05:21:32 INFO - 'SHELL': '/bin/bash', 05:21:32 INFO - 'SHLVL': '1', 05:21:32 INFO - 'TERM': 'linux', 05:21:32 INFO - 'TMOUT': '86400', 05:21:32 INFO - 'USER': 'cltbld', 05:21:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:32 INFO - '_': '/tools/buildbot/bin/python'} 05:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:34 INFO - Installing collected packages: mozsystemmonitor 05:21:34 INFO - Running setup.py install for mozsystemmonitor 05:21:34 INFO - Successfully installed mozsystemmonitor 05:21:34 INFO - Cleaning up... 05:21:34 INFO - Return code: 0 05:21:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:34 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:34 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 05:21:34 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 05:21:34 INFO - Using env: {'DISPLAY': ':0', 05:21:34 INFO - 'HOME': '/home/cltbld', 05:21:34 INFO - 'LANG': 'en_US.UTF-8', 05:21:34 INFO - 'LANGUAGE': 'en_US:en', 05:21:34 INFO - 'LOGNAME': 'cltbld', 05:21:34 INFO - 'MAIL': '/var/mail/cltbld', 05:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:34 INFO - 'MOZ_NO_REMOTE': '1', 05:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:34 INFO - 'NO_EM_RESTART': '1', 05:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:34 INFO - 'PWD': '/builds/slave/test', 05:21:34 INFO - 'SHELL': '/bin/bash', 05:21:34 INFO - 'SHLVL': '1', 05:21:34 INFO - 'TERM': 'linux', 05:21:34 INFO - 'TMOUT': '86400', 05:21:34 INFO - 'USER': 'cltbld', 05:21:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:34 INFO - '_': '/tools/buildbot/bin/python'} 05:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:36 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 05:21:36 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 05:21:36 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 05:21:36 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 05:21:36 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 05:21:36 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 05:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:37 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 05:21:37 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 05:21:37 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 05:21:37 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 05:21:37 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 05:21:37 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 05:21:37 INFO - Downloading docopt-0.6.1.tar.gz 05:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:37 INFO - Running setup.py install for blobuploader 05:21:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:37 INFO - Running setup.py install for requests 05:21:37 INFO - Running setup.py install for docopt 05:21:37 INFO - Successfully installed blobuploader requests docopt 05:21:37 INFO - Cleaning up... 05:21:37 INFO - Return code: 0 05:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:37 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:37 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 05:21:37 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 05:21:37 INFO - Using env: {'DISPLAY': ':0', 05:21:37 INFO - 'HOME': '/home/cltbld', 05:21:37 INFO - 'LANG': 'en_US.UTF-8', 05:21:37 INFO - 'LANGUAGE': 'en_US:en', 05:21:37 INFO - 'LOGNAME': 'cltbld', 05:21:37 INFO - 'MAIL': '/var/mail/cltbld', 05:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:37 INFO - 'MOZ_NO_REMOTE': '1', 05:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:37 INFO - 'NO_EM_RESTART': '1', 05:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:37 INFO - 'PWD': '/builds/slave/test', 05:21:37 INFO - 'SHELL': '/bin/bash', 05:21:37 INFO - 'SHLVL': '1', 05:21:37 INFO - 'TERM': 'linux', 05:21:37 INFO - 'TMOUT': '86400', 05:21:37 INFO - 'USER': 'cltbld', 05:21:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:37 INFO - '_': '/tools/buildbot/bin/python'} 05:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:38 INFO - Running setup.py (path:/tmp/pip-aapVlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:38 INFO - Running setup.py (path:/tmp/pip-LY2MFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:38 INFO - Running setup.py (path:/tmp/pip-BgMXhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:38 INFO - Running setup.py (path:/tmp/pip-LS0eMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:38 INFO - Running setup.py (path:/tmp/pip-_OUREk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:38 INFO - Running setup.py (path:/tmp/pip-kevUyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:38 INFO - Running setup.py (path:/tmp/pip-PfwKqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:38 INFO - Running setup.py (path:/tmp/pip-HRPjqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:38 INFO - Running setup.py (path:/tmp/pip-iEWeC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:38 INFO - Running setup.py (path:/tmp/pip-6TnVnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:38 INFO - Running setup.py (path:/tmp/pip-8Jg33k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:38 INFO - Running setup.py (path:/tmp/pip-4V65bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:39 INFO - Running setup.py (path:/tmp/pip-acLSZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:39 INFO - Running setup.py (path:/tmp/pip-qbY5Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:39 INFO - Running setup.py (path:/tmp/pip-9YIe0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:39 INFO - Running setup.py (path:/tmp/pip-RLeMYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:39 INFO - Running setup.py (path:/tmp/pip-8vcfX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:39 INFO - Running setup.py install for manifestparser 05:21:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozcrash 05:21:39 INFO - Running setup.py install for mozdebug 05:21:39 INFO - Running setup.py install for mozdevice 05:21:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozfile 05:21:39 INFO - Running setup.py install for mozhttpd 05:21:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozinfo 05:21:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozInstall 05:21:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozleak 05:21:40 INFO - Running setup.py install for mozlog 05:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for moznetwork 05:21:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozprocess 05:21:40 INFO - Running setup.py install for mozprofile 05:21:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozrunner 05:21:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozscreenshot 05:21:40 INFO - Running setup.py install for moztest 05:21:41 INFO - Running setup.py install for mozversion 05:21:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:41 INFO - Cleaning up... 05:21:41 INFO - Return code: 0 05:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:41 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:41 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 05:21:41 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 05:21:41 INFO - Using env: {'DISPLAY': ':0', 05:21:41 INFO - 'HOME': '/home/cltbld', 05:21:41 INFO - 'LANG': 'en_US.UTF-8', 05:21:41 INFO - 'LANGUAGE': 'en_US:en', 05:21:41 INFO - 'LOGNAME': 'cltbld', 05:21:41 INFO - 'MAIL': '/var/mail/cltbld', 05:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:41 INFO - 'MOZ_NO_REMOTE': '1', 05:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:41 INFO - 'NO_EM_RESTART': '1', 05:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:41 INFO - 'PWD': '/builds/slave/test', 05:21:41 INFO - 'SHELL': '/bin/bash', 05:21:41 INFO - 'SHLVL': '1', 05:21:41 INFO - 'TERM': 'linux', 05:21:41 INFO - 'TMOUT': '86400', 05:21:41 INFO - 'USER': 'cltbld', 05:21:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:41 INFO - '_': '/tools/buildbot/bin/python'} 05:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:41 INFO - Running setup.py (path:/tmp/pip-RHMAqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:41 INFO - Running setup.py (path:/tmp/pip-qphTqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:41 INFO - Running setup.py (path:/tmp/pip-s44fk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:41 INFO - Running setup.py (path:/tmp/pip-hce_lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:41 INFO - Running setup.py (path:/tmp/pip-AhD1yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:41 INFO - Running setup.py (path:/tmp/pip-vWycBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:41 INFO - Running setup.py (path:/tmp/pip-C7pmnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:41 INFO - Running setup.py (path:/tmp/pip-BcuwYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:41 INFO - Running setup.py (path:/tmp/pip-4w4GFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:41 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)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:41 INFO - Running setup.py (path:/tmp/pip-ihdCU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:42 INFO - Running setup.py (path:/tmp/pip-iP6UvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:42 INFO - Running setup.py (path:/tmp/pip-8rk0zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:42 INFO - Running setup.py (path:/tmp/pip-Hf6EJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:42 INFO - Running setup.py (path:/tmp/pip-sanyzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:42 INFO - Running setup.py (path:/tmp/pip-6u_HbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:42 INFO - Running setup.py (path:/tmp/pip-GsIRz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:42 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)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:42 INFO - Running setup.py (path:/tmp/pip-ZBvsfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:42 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)) 05:21:42 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)) 05:21:42 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)) 05:21:42 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)) 05:21:42 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)) 05:21:42 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)) 05:21:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:44 INFO - Downloading blessings-1.6.tar.gz 05:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:44 INFO - Installing collected packages: blessings 05:21:44 INFO - Running setup.py install for blessings 05:21:44 INFO - Successfully installed blessings 05:21:44 INFO - Cleaning up... 05:21:44 INFO - Return code: 0 05:21:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:44 INFO - Reading from file tmpfile_stdout 05:21:44 INFO - Current package versions: 05:21:44 INFO - argparse == 1.2.1 05:21:44 INFO - blessings == 1.6 05:21:44 INFO - blobuploader == 1.2.4 05:21:44 INFO - docopt == 0.6.1 05:21:44 INFO - manifestparser == 1.1 05:21:44 INFO - mozInstall == 1.12 05:21:44 INFO - mozcrash == 0.17 05:21:44 INFO - mozdebug == 0.1 05:21:44 INFO - mozdevice == 0.48 05:21:44 INFO - mozfile == 1.2 05:21:44 INFO - mozhttpd == 0.7 05:21:44 INFO - mozinfo == 0.9 05:21:44 INFO - mozleak == 0.1 05:21:44 INFO - mozlog == 3.1 05:21:44 INFO - moznetwork == 0.27 05:21:44 INFO - mozprocess == 0.22 05:21:44 INFO - mozprofile == 0.28 05:21:44 INFO - mozrunner == 6.11 05:21:44 INFO - mozscreenshot == 0.1 05:21:44 INFO - mozsystemmonitor == 0.0 05:21:44 INFO - moztest == 0.7 05:21:44 INFO - mozversion == 1.4 05:21:44 INFO - psutil == 3.1.1 05:21:44 INFO - requests == 1.2.3 05:21:44 INFO - wsgiref == 0.1.2 05:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:44 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 05:21:44 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 05:21:44 INFO - Using env: {'DISPLAY': ':0', 05:21:44 INFO - 'HOME': '/home/cltbld', 05:21:44 INFO - 'LANG': 'en_US.UTF-8', 05:21:44 INFO - 'LANGUAGE': 'en_US:en', 05:21:44 INFO - 'LOGNAME': 'cltbld', 05:21:44 INFO - 'MAIL': '/var/mail/cltbld', 05:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:44 INFO - 'MOZ_NO_REMOTE': '1', 05:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:44 INFO - 'NO_EM_RESTART': '1', 05:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:44 INFO - 'PWD': '/builds/slave/test', 05:21:44 INFO - 'SHELL': '/bin/bash', 05:21:44 INFO - 'SHLVL': '1', 05:21:44 INFO - 'TERM': 'linux', 05:21:44 INFO - 'TMOUT': '86400', 05:21:44 INFO - 'USER': 'cltbld', 05:21:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:44 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 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)) 05:21:45 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:45 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')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:45 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 05:21:45 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 05:21:45 INFO - Using env: {'DISPLAY': ':0', 05:21:45 INFO - 'HOME': '/home/cltbld', 05:21:45 INFO - 'LANG': 'en_US.UTF-8', 05:21:45 INFO - 'LANGUAGE': 'en_US:en', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MAIL': '/var/mail/cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SHLVL': '1', 05:21:45 INFO - 'TERM': 'linux', 05:21:45 INFO - 'TMOUT': '86400', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 INFO - Downloading/unpacking jsonschema 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:47 INFO - warning: no files found matching '*.txt' 05:21:47 INFO - no previously-included directories found matching 'build' 05:21:47 INFO - no previously-included directories found matching 'dist' 05:21:47 INFO - no previously-included directories found matching '.git*' 05:21:47 INFO - Installing collected packages: jsonschema, functools32 05:21:47 INFO - Running setup.py install for functools32 05:21:47 INFO - warning: no files found matching '*.txt' 05:21:47 INFO - no previously-included directories found matching 'build' 05:21:47 INFO - no previously-included directories found matching 'dist' 05:21:47 INFO - no previously-included directories found matching '.git*' 05:21:47 INFO - Successfully installed jsonschema functools32 05:21:47 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 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 0x7f4782007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', '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 05:21:47 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 05:21:47 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 05:21:47 INFO - Using env: {'DISPLAY': ':0', 05:21:47 INFO - 'HOME': '/home/cltbld', 05:21:47 INFO - 'LANG': 'en_US.UTF-8', 05:21:47 INFO - 'LANGUAGE': 'en_US:en', 05:21:47 INFO - 'LOGNAME': 'cltbld', 05:21:47 INFO - 'MAIL': '/var/mail/cltbld', 05:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:47 INFO - 'MOZ_NO_REMOTE': '1', 05:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:47 INFO - 'NO_EM_RESTART': '1', 05:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:47 INFO - 'PWD': '/builds/slave/test', 05:21:47 INFO - 'SHELL': '/bin/bash', 05:21:47 INFO - 'SHLVL': '1', 05:21:47 INFO - 'TERM': 'linux', 05:21:47 INFO - 'TMOUT': '86400', 05:21:47 INFO - 'USER': 'cltbld', 05:21:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:47 INFO - '_': '/tools/buildbot/bin/python'} 05:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:47 INFO - Downloading/unpacking flake8 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 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 05:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:50 INFO - no previously-included directories found matching 'docs/_build' 05:21:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:50 INFO - Running setup.py install for pep8 05:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:50 INFO - no previously-included directories found matching 'docs/_build' 05:21:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:50 INFO - Cleaning up... 05:21:50 INFO - Return code: 0 05:21:50 INFO - Running post-action listener: _resource_record_post_action 05:21:50 INFO - Running post-action listener: _start_resource_monitoring 05:21:50 INFO - Starting resource monitoring. 05:21:50 INFO - ##### 05:21:50 INFO - ##### Running install step. 05:21:50 INFO - ##### 05:21:50 INFO - Running pre-action listener: _resource_record_pre_action 05:21:50 INFO - Running main action method: install 05:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:51 INFO - Reading from file tmpfile_stdout 05:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:51 INFO - Reading from file tmpfile_stdout 05:21:51 INFO - Output received: 05:21:51 INFO - Usage: mozinstall [options] installer 05:21:51 INFO - Options: 05:21:51 INFO - -h, --help show this help message and exit 05:21:51 INFO - -d DEST, --destination=DEST 05:21:51 INFO - Directory to install application into. [default: 05:21:51 INFO - "/builds/slave/test"] 05:21:51 INFO - --app=APP Application being installed. [default: firefox] 05:21:51 INFO - mkdir: /builds/slave/test/build/application 05:21:51 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'] 05:21:51 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 05:22:06 INFO - Reading from file tmpfile_stdout 05:22:06 INFO - Output received: 05:22:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:06 INFO - Running post-action listener: _resource_record_post_action 05:22:06 INFO - ##### 05:22:06 INFO - ##### Running run-tests step. 05:22:06 INFO - ##### 05:22:06 INFO - Running pre-action listener: _resource_record_pre_action 05:22:06 INFO - Running main action method: run_tests 05:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:06 INFO - Python 2.7.3 05:22:06 INFO - Return code: 0 05:22:06 INFO - grabbing minidump binary from tooltool 05:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:06 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 0x278f410>, '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 0x2790310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27907a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:06 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 05:22:06 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 05:22:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:06 INFO - Return code: 0 05:22:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:07 INFO - Return code: 0 05:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:22:07 INFO - Using env: {'DISPLAY': ':0', 05:22:07 INFO - 'HOME': '/home/cltbld', 05:22:07 INFO - 'LANG': 'en_US.UTF-8', 05:22:07 INFO - 'LANGUAGE': 'en_US:en', 05:22:07 INFO - 'LOGNAME': 'cltbld', 05:22:07 INFO - 'MAIL': '/var/mail/cltbld', 05:22:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:07 INFO - 'MOZ_NO_REMOTE': '1', 05:22:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:07 INFO - 'NO_EM_RESTART': '1', 05:22:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:07 INFO - 'PWD': '/builds/slave/test', 05:22:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:07 INFO - 'SHELL': '/bin/bash', 05:22:07 INFO - 'SHLVL': '1', 05:22:07 INFO - 'TERM': 'linux', 05:22:07 INFO - 'TMOUT': '86400', 05:22:07 INFO - 'USER': 'cltbld', 05:22:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461586872.946478-1024073400', 05:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:07 INFO - '_': '/tools/buildbot/bin/python'} 05:22:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:22:08 INFO - mozversion application_buildid: 20160422035423 05:22:08 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:22:08 INFO - mozversion application_display_name: Nightly 05:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:08 INFO - mozversion application_name: Firefox 05:22:08 INFO - mozversion application_remotingname: firefox 05:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:08 INFO - mozversion application_vendor: Mozilla 05:22:08 INFO - mozversion application_version: 48.0a1 05:22:08 INFO - mozversion platform_buildid: 20160422035423 05:22:08 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:08 INFO - mozversion platform_version: 48.0a1 05:22:08 INFO - using testdate: 1461586928 05:22:08 INFO - actual date: 1461586928 05:22:08 INFO - starting webserver on 'localhost:39798' 05:22:08 INFO - SUITE-START | Running 2 tests 05:22:08 INFO - TEST-START | dromaeo_css 05:22:08 INFO - operating with platform_type : linux_ 05:22:08 INFO - Initialising browser for dromaeo_css test... 05:22:08 INFO - TEST-INFO | started process 30787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXfs2N/profile http://localhost:39798/getInfo.html) 05:22:12 INFO - PROCESS | 30787 | __metrics Screen width/height:1600/1200 05:22:12 INFO - PROCESS | 30787 | colorDepth:24 05:22:12 INFO - PROCESS | 30787 | Browser inner width/height: 1024/697 05:22:12 INFO - PROCESS | 30787 | __metrics 05:22:13 ERROR - PROCESS | 30787 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:22:14 INFO - TEST-INFO | 30787: exit 0 05:22:14 INFO - Browser initialized. 05:22:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:14 INFO - TEST-INFO | started process 30865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXfs2N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:26 INFO - PROCESS | 30865 | RSS: Main: 155750400 05:22:26 INFO - PROCESS | 30865 | 05:23:17 INFO - PROCESS | 30865 | 1461586997870 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:25:29 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39798/tests/dromaeo/cssquery-ext.html) 05:25:30 INFO - PROCESS | 30865 | RSS: Main: 266014720 05:25:30 INFO - PROCESS | 30865 | 05:28:32 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-ext.html (next: http://localhost:39798/tests/dromaeo/cssquery-jquery.html) 05:28:33 INFO - PROCESS | 30865 | RSS: Main: 238678016 05:28:33 INFO - PROCESS | 30865 | 05:31:34 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39798/tests/dromaeo/cssquery-mootools.html) 05:31:35 INFO - PROCESS | 30865 | RSS: Main: 241999872 05:31:35 INFO - PROCESS | 30865 | 05:34:37 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39798/tests/dromaeo/cssquery-prototype.html) 05:34:38 INFO - PROCESS | 30865 | RSS: Main: 231542784 05:34:38 INFO - PROCESS | 30865 | 05:37:41 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39798/tests/dromaeo/cssquery-yui.html) 05:37:41 INFO - PROCESS | 30865 | RSS: Main: 222240768 05:37:41 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | Cycle 1(1): loaded http://localhost:39798/tests/dromaeo/cssquery-yui.html (next: http://localhost:39798/tests/dromaeo/cssquery-dojo.html) 05:40:44 INFO - PROCESS | 30865 | RSS: Main: 258428928 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | __start_tp_report 05:40:44 INFO - PROCESS | 30865 | _x_x_mozilla_page_load 05:40:44 INFO - PROCESS | 30865 | _x_x_mozilla_page_load_details 05:40:44 INFO - PROCESS | 30865 | |i|pagename|runs| 05:40:44 INFO - PROCESS | 30865 | |0;dojo.html;2583.0055428659966;2693.133900867213;2693.9191824245254;2698.123109989254;2700.6894207166183;4523.163214805255;4607.940173760037;4696.319033740106;4697;4720.527947205278;4700.623950083994;4719.693219940701;4766.809327626891;4806.0628177505405;4806.447258565266;4309.922519370165;4324.329728892027;4374.934375984363;4389.144116897206;4448.132614140244;4326.242907491192;4358.106588149421;4440.023194897118;4466.039801442689;4469.486009108945;4237.194932962727;4371.191329604034;4404.4494438195225;4420.425344705168;4423.115376924612;4238.766867822269;4248.086661367821;4275.5724427557;4280.72175308604;4340.8697739067875;4305.827766889321;4336.739795612273;4340.370646256307;4374.147041326943;4393.033532622818;4535.342375355555;4608.28571571407;4618.284165954283;4618.953810461886;4636.652251081183;5052.216906379517;5087.236914462823;5098.388193416777;5142.331496905415;5155.61332900034;5049.242613607951;5074.847754567332;5076.23856421536;5087.49125087492;5134.64057515974;4604.7927843247135;4707.29390591414;4720.3863497745415;4740.6681532292405;4741.170295198326;5133.153029750049;5142.537171654494;5164.14791559396;5172.379314482287;5213.869653258699;4949.282354058713;4957.82647607332;4958.1323268428605;4961.231009193581;5002;4909.4354149273295;5030.471800460972;5033.84898453047;5034.622403319766;5120.539151476385;5025.47232540578;5049.368828896388;5060.974695126501;5061.063703214917;5062.240663900371;5030.673006254582;5031.6729412588065;5032;5035.471275516018;5066.16408292635;4159.126583417456;4225.7887105644595;4244.129953359554;4299.355096735515;4320.740755554677;3685.8709945152327;3701.9074523137137;3705.5738590061947;3742.139307959185;3753.0429740416566;4302.354646802942;4303.483581970184;4308.052228509723;4350.151720414488;4355.259605867011;4929.309896614477;4974.353334066621;5027.4469808321055;5065.822696205615;5071.137906555894;4234.978825105916;4247.575242475789;4256.233877901946;4278.807453664593;4292.377605247221;4439.134368798053;4439.356293337448;4444.155610434007;4484.461864576207;4492.124035813051;4614.284785858197;4718.457377401643;4787.281907713871;4807.735574543433;4820.855374338776;5066.594672426123;5088.185890257541;5104.259882317117;5113.849383888595;5157.226416037624;4589.5639914208095;4773.689710168828;4800.423949126127;4802.423709154924;4852.587530059985;4909.26361045846;4971.130052240916;4982.451930287593;4983.25251212321;4986.501349864984;4969.428515720739;5030.044291584587;5032.949670503248;5035.546800787946;5062.417821950523;4811.109944660249;4869.415670119608;4871.244957031666;4871.464138944642;4918.262260660929;4751.382320298478;4895.975520122377;4942.283368911416;4974.651774375759;4992.950070499249;4806.062817750645;4810.7113573185725;4820.68665536739;4827.444843843003;4850.927236091532;4804.663673542818;4923.950760492349;4929.975350123226;4931.211006239128;4975.477574854588;4754.096721622881;4823.517648235148;4832.661713680009;4868.513148685103;4873.122837889214 05:40:44 INFO - PROCESS | 30865 | |1;ext.html;565.7199686155353;583.9065749480084;592.3277080513617;600.4175949329149;609.9329073801882;34296.828515857414;35435.645643543525;35440.64559354405;35505.206797082385;35575.28849423013;36846.8157659212;37697.43453848187;37709.622903770956;37740.24519509615;37772;7616.314531692133;7806.1413244543055;7813.726519571816;7819.452638315321;7820.100688420819;7567.848643027136;7693.230676932318;7704.422168337369;7704.998350214464;7707.499012564165;7792.298693117618;7855.93944817448;7856.2536559027085;7857.882131768028;7861.724839630586;7776.844463110734;7815.296623303873;7830.6084695764985;7836.373090152774;7841.764747057598;7696.807579810494;7774.067111946546;7781.688732450695;7950.204979502061;7958.084820245688;36948.630513695054;37379.439308410394;37438.8128059358;37493.437598436045;37523.4371484428;2705.8105932584726;2981.8956336528117;3358.177246574605;3436.810975396352;3535.7701749386465;27024.864875675692;28625.713742862514;28638.856805715837;28944.27639309013;29367.55948660772;3495.598006229265;3498.1079824644808;3527.1005893496995;3559.341521818446;3634.9818250908843;233760;235193;235762.99999999828;235817;236638;48513.75743121332;49614.50385496171;49728.75135624299;49737.502624973284;49738.75130624396;57226;58647;58707.119393209134;58712.41287587155;58773;13427.26150061756;13629.659258518419;13640.93179534116;13642.658933526543;13658.590242292747;9159.175674189222;9173.40372875761;9188;9192.908070919339;9198.908010919939;17557.824421755875;17662.381816636356;17753.201105950262;18265.45203643893;18329.90835045816;6581.80254592363;6800.795976120724;6904.344087311697;6951.443884489228;6979.581225126509;839.7648658375665;873.4977388001925;931.1293940165831;984.414273507262;992.0971915556809;26263.606045909328;27477.17568472949;28032.159035228975;28047.615952643846;28053;934.3926447808979;937.4188003437775;961.3943215774018;1038.8597539332093;1054.8312270036756;14450.060746051473;14870.925645371704;14899.47851825181;15080.698386032438;15197.848021519865;342956;347927;351513;351547;352252;46537.53462465332;48035.27947080797;48190;48197;48223.5177648226;1160.5067846165514;1203.4043148641479;1219.603628820637;1225.40567824605;1240.5658019693215;26172.083977060713;26969.595456067782;27035;27271.454570908867;27297.72702272952;41688;42060.57939420689;42181.367279490216;42272;42323;254117;254304;254440;254637;255060;24838.254852354457;25425.237242882744;39409.60590394174;40857.59142408657;40957.590424095375;39335.213295734495;39685;40287.1942561153;40372.79813600913;40605;34506.482402763475;34910.301793964485;35196;35360.82319588386;35561.46657800187;33741.49387759136;34410;34597.30805383828;34689.47965780465;34730.82634586811;28388.43223135567;33445.33109337848;33783.3243335127;34109.317813644084;37063.81468092642;27437.868497649397;28546;29256;29553.26116847096;29745;24474.63288050645;25537.74462255428;25538.74461255438;25743.227703168934;26555.486843942967 05:40:44 INFO - PROCESS | 30865 | |2;jquery.html;380.16553664705964;381.715621861713;384.50975006866224;387.13282247765;398.936170212766;15630.452934147306;16656.250468728907;16757.41349052782;16775.412860549884;16788.58028549287;10256.794864102732;10724.78550428991;10751.784964300708;10760.192985526077;10784.514696838642;4620.676552641316;4722.90554188916;4772;4773;4796.640251981098;4580.633549316063;4740.834070807522;4747.121782470237;4752.928706069411;4758.072175925696;4726.480087190406;4756.381670382845;4768.833090841821;4769.260764581495;4809.086273608021;4676.415448068991;4772.236442169271;4781.617470602343;4806.086843499724;4808.3989501312335;4680.9297860532115;4690.788914498856;4691.7654117294;4697.835575754866;5014.323066386064;12196.207246528948;12196.878031219752;12388.194767340094;12395.318257495834;12414.503419863195;1890.4423195157324;1933.4779609505356;1942.2619404626294;1944.2903340280836;2004.0681083296192;9111.863322050174;9249.35254532183;9638.373505722106;11515.769684606345;13458.088432070208;1696.457133717211;1749.0297025751472;1809.7918739345012;1839.9724004139814;1848.7504186934725;71018;71543.6422817893;71856.64071679609;72205;72372;9984.450855203033;10115.797684046278;10403.635872744419;10472.266941314036;10554.2084343673;14255.64360890986;14338.992541044263;14378.856211437751;14424.927875360556;14466.566003019927;7019.4735394844565;7070.6919219944475;7121.9643901780155;7129.679164437613;7143.535670181422;6700.195976482853;6707.094542236736;6746.359095885883;6874.312568743086;6876.243613202544;4477.686561940698;4482.887927801831;4501.549845015472;4511.210538155809;4551.3173024046;1844.9446516604523;1890.1588792986988;1904.6095550412133;1917.4918646558674;1918.098493707955;808.6644042722204;847.7541512961295;894.3739382432193;950.3062764182185;957.6648173139346;16295.59261018484;16522.75215871763;16625.91687041557;16669.749953750703;17096.91451542759;872.3675335381797;891.9063498332712;902.4269588811021;926.4672813132476;958.7794807194384;9044.41211321262;9493.572789224501;9496.572654230577;9499.762505937408;9627;376624;388921;394954;396927;404882;68105;81712.18287817165;82032;84307;86587.13412865916;907.4782000349693;916.0518862976787;921;924.12670026824;926.4487629860357;14585.343659535134;14713.55859324222;14762.926185369004;14769.187694676895;14787.260636967894;33500.83249583736;34239.14402139966;34383.48424773681;34550.13624659403;35105;42737.52930531915;44781.77609111933;46796.29805552988;47180.80114406465;49199.75400122976;7522.774316770506;7778.183290754389;7794.493357931717;7807.687692492236;7910.802229944297;8730.956345218234;11189.272697274651;11220.382878941737;12003.099767517297;12063.336516491678;10170.135538479311;10211.693649190536;10316.071553560216;10519;10622.628208012682;9853.113219810251;9891.55488003056;10044.849327259952;10156.898431015596;10467.895321046692;9950.800983980425;10035.09684128432;10180.694579162637;10352.378857268588;10464.37213767146;7482.925170748223;7574.81062973408;7610.200928902385;7637.809054773675;7814.257645523666;9086.363954523384;9534.380265283013;9785;9831.262655300738;9892.851607225753 05:40:44 INFO - PROCESS | 30865 | |3;mootools.html;1235.1847780464896;1459.5037687186357;1462.1446453824512;1621;1787.6603445345393;6883.79348619541;7121.679524421401;7759.534427934328;7977.242161994615;7992.080910695272;7776.066871975357;7777.18339574345;7790.220977902207;7856.882146767803;7864.882026769603;2226.8997895094717;2282.4978504728933;2283.4519715268298;2286.4626812699003;2290.7823756743164;2226.6882636430914;2246.550689862026;2262.049939025613;2282.1441959265276;2285.9771402285933;2260.2880092770724;2269.6028195065796;2272.6363781794917;2313.9652905206435;2317.2121478697322;2234.3297010896667;2247;2258.2096266306826;2260;2261.683364328995;2194.7585765565773;2207.381933058746;2210.458437682778;2212.0930418528487;2214.8228141748623;7784.3772498200005;7870.0949390820215;7903.446758726834;7907.169747176578;7918.881216781753;4622.560856718606;4761.285807128924;4765.857024289242;4774.188387974053;4791.329213910055;2901.376204116104;2932.8680209390627;2959.201015725742;2960.0379876539996;2961.2596850787304;932.5290728182292;945.6170251048336;951.1202138022371;966.917811985982;974.1622204903778;10466.215033872413;10872.402017888933;10976.506057227363;11019.724506887393;11024;4103.302438585448;4275.593818587229;4355.825766969286;4358.171947329997;4370.322599996942;8270.172982701803;8376.790580235544;8377.329813614897;8396;8431.662733490592;4677.041206552649;4687.156311863897;4687.6249900007915;4711.882202944954;4720.929186062212;3693.261347730465;3817.9045523862123;4154.522229943595;4297.914041719148;4335.371371151228;3390.338883917662;3431.3995050866497;3512.7014203792965;3525.4183059794846;3526.118470382404;1037.180627304436;1084.4252546150553;1089.0851684584986;1101.801675698366;1102.6251074634663;700.6916956539106;797.6889013284823;819.3445243805052;821.1131977464324;826.7891687619618;4842.951570484321;5063.1269672617655;5086.9745651271505;5190.221466779938;5231.555317797954;862.1335557764532;887.316766090107;899.5007770687331;912.5026860361119;914.2320450821342;3311.106001379614;3410.36908171989;3412.6587341265677;3443.2252743132594;3484.3902317094407;9573.664921727706;9868.703938881845;9901.900980990242;9963.402195868272;9982.201423886072;9757.316987810786;9828.508574571242;9836.704898853046;9916.702498925044;9917.702468925943;7481.513701609378;7628.199039100926;7643.464957453036;7658.195889431641;7662.923370766221;4856.271559266138;4990.900181996267;4996.825111121093;5061.367329083864;5112.105381558287;9155.038720934472;9194.402363846597;9204.447733136034;9366.250699943852;9376.671816486663;8808.779780505538;9039.864402034107;9149.679761208326;9170.403923744936;9343.34596578233;6044.184035155374;6525.64108974011;6541.247756508063;6685.832854178684;6778.96610516964;7273.527220730635;7301.160366557914;7356.521826081287;7368.778936631909;7380.446466514925;6372.107904893226;6600.339966003361;6640.634765087966;6733.124693789776;6747.257801641914;6533.314002029719;6614.206295244601;6630.436412904957;6632.535722499379;6636.834079147867;6189.257289125154;6221.688915554295;6255.24937007562;6270;6270.310265870659;4401.229784787585;4465.553444655508;4653.069386122721;4721.173794586002;4722.716637001791;4538.500764915922;4580.541945805393;4679.649026322972;4689.484156742824;4700.9529904701885 05:40:44 INFO - PROCESS | 30865 | |4;prototype.html;312.49064025638205;315.20568168216096;321.41342050757373;325.15459804508293;328.4268950681062;4927.950720492794;5042.688900885769;5099.4390617032095;5127.897442051157;5134.717590532519;4833.4441539223;5033.245013248005;5050.646454748169;5050.974745126278;5094.439611642716;3994.2810294147116;4007.3788562772816;4009.0578714002186;4016.4577781999496;4016.513889860741;3774.6602805747475;3839.0978120141745;3996.7601943883315;4007.6793856491413;4017.8191981360765;3958.129211573449;3976.324024915771;3990.4413382126527;3994.6005399460114;3997.5202975642965;3956.7823769692654;3964.940525892114;3970.900727481836;3973.3642617181113;3977.76133431995;3457.4468085106264;3525.94711079334;3529.523514325559;3532.5054492371087;3541.220931395089;4818.71087734737;4823.348847905523;4826.251930950708;4838.491958344393;4842.370491836074;4548.658145846983;4560.315952607102;4565.977170114162;4569.634429245652;4572.4910779443035;5179.249008893689;5308.681479111266;5309.486796263085;5312.1766126250495;5332.466753324637;3796.6013568575177;3841.4621952926614;3845.5000849889616;3849.345611246095;3862.6909847212155;5575.2473416088715;5606.971965140148;5607.551395888319;5623.718814059281;5623.9437605623825;3951.881443556698;3955.4264631628253;3964.7621142731527;3966.127451960564;3966.2067586482817;3904.1801221743185;3998.3802510610903;4000.5399379071196;4012.257732319472;4032.8991775205855;4512.210363186429;4515.68390212682;4518.6611004174165;4544.386507821402;4554.908901821945;5319.840404787863;5335.10603735676;5346.331708536433;5347.465253474699;5361.597880159004;1300.518808041031;1308.5093090091216;1379;1394.7489451898755;1406.2757679794913;936.9718908432758;939.5912777941618;962.2206013129388;964.1611797735875;972.4554249620236;4657;4666.4633567139535;4668.929966050512;4681.95318046822;4687.695299805502;5426.077566813651;5445.156000819879;5452.291202143696;5460.34475862891;5463.644863083887;4548.56788605082;4658.091672123904;4665.183592871234;4671.696339737906;4675.906481870344;2888.6966868478507;2928.282570770132;2935.2661834541364;2935.955960660549;2944.7349738523635;5141.126008578551;5142.922856157161;5152.252923326172;5156.329677142023;5162.97418512905;5459.590530710213;5599.860003499945;5607.271054762855;5613.550915926716;5618.775248989995;5124.333836601292;5139.483852263516;5147.099257629975;5148.459411761786;5168.8449346519665;5467.152591348347;5467.890642187213;5469.835904922858;5470.562355011669;5475.479829416199;5194.818181363634;5367.382750983531;5367.838964831061;5368.543673787772;5376.166694162411;5103.540681338697;5122.718250496109;5137.280780690631;5140.897182056413;5163.586913047023;3908.843646254118;3916.2167566487387;3918.9216215676097;3919.5296564411315;3926.1362500249897;5097.92353114711;5268.550124192269;5517.613767036269;5537.612367134262;5547.805826796042;5354.46455354477;5354.973225134006;5369;5371.274877891435;5376.327959005124;5339.893202136013;5370.087085195448;5375.247465354775;5376.408595054619;5379.946200537945;5128.410232823124;5311.734413279243;5314;5314.202869569595;5325.946740532545;5382.919256211082;5400.2439658447065;5401.513863752281;5405.297311349499;5413.593980451561;5074.644774865724;5248.763805628832;5259.868503287448;5287.64699708626;5287.762050707651 05:40:44 INFO - PROCESS | 30865 | |5;yui.html;665.943394811441;721.732958805242;733.537871141181;745.128200005993;780.7462574663236;11597.536098556058;13083.215007099569;13517.797233041487;13558.796618050737;13559.593212203637;13525.256110913895;13583.981201409884;13611.591652250423;13667;13831.239281839495;628.0704557255265;778.5250996891891;795.6300320351036;797.8763291689797;798.0264077825044;760.1182628151346;795.3120550723611;795.6220795122329;797.1948332184506;797.6251161953872;820.782492639451;825.1006403020706;826.3471857232779;826.3471857232809;827.0158511371449;655.7180412422656;794.2613369566301;826.0459169659053;826.4215049465398;826.9875951860727;596.4602035158189;596.5198015597442;596.5645079092287;596.9850753731148;597.5458651424905;12959.87040129596;13011;13020.153690010215;13020.739585208337;13030;11009.61466348674;11110.277831940979;11265.943670281596;11398.60104896333;11526.654200374001;10059.295849290553;10060.698179054567;10113.89886101137;10157.39055656663;10197.643082492077;3226.1128189748006;3250.658680838525;3296.653851345622;3327.4842399428126;3357.5131605917004;46507.767461162475;46931.530684693054;47041.29438058432;47048.059038819374;47064.7646761764;7983.960080199562;8161.387895907831;8163.959180204061;8187.672493100328;8587.742367728979;14624.926875365554;14700.926495367456;14839.70320593582;14841.851581484047;14856.702865942621;6424.903626445607;6429.38920802523;6484.286728459866;6620;6711.865762684719;3604.279144171176;3685.5577330720484;3696.611855755161;3704.1665625234104;3704.1850792825535;2950.749186319144;2952.070097919149;2985.477541430241;2995.5207166853197;3000.189948713835;471.41779901821224;521.3092652235803;533.4185737546094;539.635745871543;548.8682716148176;385.3064483928917;535.1277417808947;541.3638974205293;572.5562688916124;577.7342422485704;7155.248698886542;7259.491835571459;7484.951324035726;7686.308232259012;7779.572123533147;454.7339806213336;516.8578640873715;532.2335836395578;545.3987547883218;557.5066066531149;3628.872989445357;3756.192418629953;3757.4739536464917;3780.8109594520715;3880.1269714314053;50149.49850501521;52422.47577524176;52432.737836310574;52497.2125418119;52611;43877.341839872424;44556;44619;44759;45481.31778023332;41405.9961305603;41641;41925.371119433235;42368.57631423646;42786.35820462696;7032.437405007689;7140.158294555136;7297.160826504807;7327.596982165819;7390.778276651709;26325.21024369272;26377.340566485993;26516.867415662797;26994;27189.59215611728;33275.50086748749;33894.8305258482;34404.655953440146;35590;36196;9899.505024748878;9973.152282056106;10031.247656425652;10040.397576145455;10178.796424071625;10054.29619926598;10320.174386049248;10589.470526473491;10718.571257149939;11068.446577671246;10394.688159355232;10444.42555659446;10550.472476375997;10555.94722026385;11039.944800275947;10036.297459177787;10696.518656660313;10747.408892510673;10802.783944321227;11205.43972801373;9773.218142548436;9792.608295668093;9812.705618831447;9903.306768526134;10218.54016569271;8874.112588741074;9086;9092.090011591106;9339.53302334867;9449.527523623654;8433.19884610961;8442.15578442151;8445.873311900203;8623.969562460208;8761.386702930733 05:40:44 INFO - PROCESS | 30865 | __end_tp_report 05:40:44 INFO - PROCESS | 30865 | __start_cc_report 05:40:44 INFO - PROCESS | 30865 | _x_x_mozilla_cycle_collect,964 05:40:44 INFO - PROCESS | 30865 | __end_cc_report 05:40:44 INFO - PROCESS | 30865 | __startTimestamp1461588044909__endTimestamp 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | ------- Summary: start ------- 05:40:44 INFO - PROCESS | 30865 | Number of tests: 6 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#0] dojo.html Cycles:165 Average:4654.34 Median:4804.66 stddev:488.58 (10.2%) stddev-sans-first:462.27 05:40:44 INFO - PROCESS | 30865 | Values: 2583.0 2693.1 2693.9 2698.1 2700.7 4523.2 4607.9 4696.3 4697.0 4720.5 4700.6 4719.7 4766.8 4806.1 4806.4 4309.9 4324.3 4374.9 4389.1 4448.1 4326.2 4358.1 4440.0 4466.0 4469.5 4237.2 4371.2 4404.4 4420.4 4423.1 4238.8 4248.1 4275.6 4280.7 4340.9 4305.8 4336.7 4340.4 4374.1 4393.0 4535.3 4608.3 4618.3 4619.0 4636.7 5052.2 5087.2 5098.4 5142.3 5155.6 5049.2 5074.8 5076.2 5087.5 5134.6 4604.8 4707.3 4720.4 4740.7 4741.2 5133.2 5142.5 5164.1 5172.4 5213.9 4949.3 4957.8 4958.1 4961.2 5002.0 4909.4 5030.5 5033.8 5034.6 5120.5 5025.5 5049.4 5061.0 5061.1 5062.2 5030.7 5031.7 5032.0 5035.5 5066.2 4159.1 4225.8 4244.1 4299.4 4320.7 3685.9 3701.9 3705.6 3742.1 3753.0 4302.4 4303.5 4308.1 4350.2 4355.3 4929.3 4974.4 5027.4 5065.8 5071.1 4235.0 4247.6 4256.2 4278.8 4292.4 4439.1 4439.4 4444.2 4484.5 4492.1 4614.3 4718.5 4787.3 4807.7 4820.9 5066.6 5088.2 5104.3 5113.8 5157.2 4589.6 4773.7 4800.4 4802.4 4852.6 4909.3 4971.1 4982.5 4983.3 4986.5 4969.4 5030.0 5032.9 5035.5 5062.4 4811.1 4869.4 4871.2 4871.5 4918.3 4751.4 4896.0 4942.3 4974.7 4993.0 4806.1 4810.7 4820.7 4827.4 4850.9 4804.7 4924.0 4930.0 4931.2 4975.5 4754.1 4823.5 4832.7 4868.5 4873.1 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#1] ext.html Cycles:180 Average:43716.28 Median:19567.32 stddev:74502.84 (380.8%) stddev-sans-first:74641.39 05:40:44 INFO - PROCESS | 30865 | Values: 565.7 583.9 592.3 600.4 609.9 34296.8 35435.6 35440.6 35505.2 35575.3 36846.8 37697.4 37709.6 37740.2 37772.0 7616.3 7806.1 7813.7 7819.5 7820.1 7567.8 7693.2 7704.4 7705.0 7707.5 7792.3 7855.9 7856.3 7857.9 7861.7 7776.8 7815.3 7830.6 7836.4 7841.8 7696.8 7774.1 7781.7 7950.2 7958.1 36948.6 37379.4 37438.8 37493.4 37523.4 2705.8 2981.9 3358.2 3436.8 3535.8 27024.9 28625.7 28638.9 28944.3 29367.6 3495.6 3498.1 3527.1 3559.3 3635.0 233760.0 235193.0 235763.0 235817.0 236638.0 48513.8 49614.5 49728.8 49737.5 49738.8 57226.0 58647.0 58707.1 58712.4 58773.0 13427.3 13629.7 13640.9 13642.7 13658.6 9159.2 9173.4 9188.0 9192.9 9198.9 17557.8 17662.4 17753.2 18265.5 18329.9 6581.8 6800.8 6904.3 6951.4 6979.6 839.8 873.5 931.1 984.4 992.1 26263.6 27477.2 28032.2 28047.6 28053.0 934.4 937.4 961.4 1038.9 1054.8 14450.1 14870.9 14899.5 15080.7 15197.8 342956.0 347927.0 351513.0 351547.0 352252.0 46537.5 48035.3 48190.0 48197.0 48223.5 1160.5 1203.4 1219.6 1225.4 1240.6 26172.1 26969.6 27035.0 27271.5 27297.7 41688.0 42060.6 42181.4 42272.0 42323.0 254117.0 254304.0 254440.0 254637.0 255060.0 24838.3 25425.2 39409.6 40857.6 40957.6 39335.2 39685.0 40287.2 40372.8 40605.0 34506.5 34910.3 35196.0 35360.8 35561.5 33741.5 34410.0 34597.3 34689.5 34730.8 28388.4 33445.3 33783.3 34109.3 37063.8 27437.9 28546.0 29256.0 29553.3 29745.0 24474.6 25537.7 25538.7 25743.2 26555.5 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#2] jquery.html Cycles:180 Average:23845.38 Median:4648.55 stddev:64963.32 (1397.5%) stddev-sans-first:65121.66 05:40:44 INFO - PROCESS | 30865 | Values: 380.2 381.7 384.5 387.1 398.9 15630.5 16656.3 16757.4 16775.4 16788.6 10256.8 10724.8 10751.8 10760.2 10784.5 4620.7 4722.9 4772.0 4773.0 4796.6 4580.6 4740.8 4747.1 4752.9 4758.1 4726.5 4756.4 4768.8 4769.3 4809.1 4676.4 4772.2 4781.6 4806.1 4808.4 4680.9 4690.8 4691.8 4697.8 5014.3 12196.2 12196.9 12388.2 12395.3 12414.5 1890.4 1933.5 1942.3 1944.3 2004.1 9111.9 9249.4 9638.4 11515.8 13458.1 1696.5 1749.0 1809.8 1840.0 1848.8 71018.0 71543.6 71856.6 72205.0 72372.0 9984.5 10115.8 10403.6 10472.3 10554.2 14255.6 14339.0 14378.9 14424.9 14466.6 7019.5 7070.7 7122.0 7129.7 7143.5 6700.2 6707.1 6746.4 6874.3 6876.2 4477.7 4482.9 4501.5 4511.2 4551.3 1844.9 1890.2 1904.6 1917.5 1918.1 808.7 847.8 894.4 950.3 957.7 16295.6 16522.8 16625.9 16669.7 17096.9 872.4 891.9 902.4 926.5 958.8 9044.4 9493.6 9496.6 9499.8 9627.0 376624.0 388921.0 394954.0 396927.0 404882.0 68105.0 81712.2 82032.0 84307.0 86587.1 907.5 916.1 921.0 924.1 926.4 14585.3 14713.6 14762.9 14769.2 14787.3 33500.8 34239.1 34383.5 34550.1 35105.0 42737.5 44781.8 46796.3 47180.8 49199.8 7522.8 7778.2 7794.5 7807.7 7910.8 8731.0 11189.3 11220.4 12003.1 12063.3 10170.1 10211.7 10316.1 10519.0 10622.6 9853.1 9891.6 10044.8 10156.9 10467.9 9950.8 10035.1 10180.7 10352.4 10464.4 7482.9 7574.8 7610.2 7637.8 7814.3 9086.4 9534.4 9785.0 9831.3 9892.9 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#3] mootools.html Cycles:180 Average:5137.43 Median:5075.05 stddev:2889.27 (56.9%) stddev-sans-first:2882.49 05:40:44 INFO - PROCESS | 30865 | Values: 1235.2 1459.5 1462.1 1621.0 1787.7 6883.8 7121.7 7759.5 7977.2 7992.1 7776.1 7777.2 7790.2 7856.9 7864.9 2226.9 2282.5 2283.5 2286.5 2290.8 2226.7 2246.6 2262.0 2282.1 2286.0 2260.3 2269.6 2272.6 2314.0 2317.2 2234.3 2247.0 2258.2 2260.0 2261.7 2194.8 2207.4 2210.5 2212.1 2214.8 7784.4 7870.1 7903.4 7907.2 7918.9 4622.6 4761.3 4765.9 4774.2 4791.3 2901.4 2932.9 2959.2 2960.0 2961.3 932.5 945.6 951.1 966.9 974.2 10466.2 10872.4 10976.5 11019.7 11024.0 4103.3 4275.6 4355.8 4358.2 4370.3 8270.2 8376.8 8377.3 8396.0 8431.7 4677.0 4687.2 4687.6 4711.9 4720.9 3693.3 3817.9 4154.5 4297.9 4335.4 3390.3 3431.4 3512.7 3525.4 3526.1 1037.2 1084.4 1089.1 1101.8 1102.6 700.7 797.7 819.3 821.1 826.8 4843.0 5063.1 5087.0 5190.2 5231.6 862.1 887.3 899.5 912.5 914.2 3311.1 3410.4 3412.7 3443.2 3484.4 9573.7 9868.7 9901.9 9963.4 9982.2 9757.3 9828.5 9836.7 9916.7 9917.7 7481.5 7628.2 7643.5 7658.2 7662.9 4856.3 4990.9 4996.8 5061.4 5112.1 9155.0 9194.4 9204.4 9366.3 9376.7 8808.8 9039.9 9149.7 9170.4 9343.3 6044.2 6525.6 6541.2 6685.8 6779.0 7273.5 7301.2 7356.5 7368.8 7380.4 6372.1 6600.3 6640.6 6733.1 6747.3 6533.3 6614.2 6630.4 6632.5 6636.8 6189.3 6221.7 6255.2 6270.0 6270.3 4401.2 4465.6 4653.1 4721.2 4722.7 4538.5 4580.5 4679.6 4689.5 4701.0 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#4] prototype.html Cycles:180 Average:4431.45 Median:5062.81 stddev:1275.30 (25.2%) stddev-sans-first:1240.84 05:40:44 INFO - PROCESS | 30865 | Values: 312.5 315.2 321.4 325.2 328.4 4928.0 5042.7 5099.4 5127.9 5134.7 4833.4 5033.2 5050.6 5051.0 5094.4 3994.3 4007.4 4009.1 4016.5 4016.5 3774.7 3839.1 3996.8 4007.7 4017.8 3958.1 3976.3 3990.4 3994.6 3997.5 3956.8 3964.9 3970.9 3973.4 3977.8 3457.4 3525.9 3529.5 3532.5 3541.2 4818.7 4823.3 4826.3 4838.5 4842.4 4548.7 4560.3 4566.0 4569.6 4572.5 5179.2 5308.7 5309.5 5312.2 5332.5 3796.6 3841.5 3845.5 3849.3 3862.7 5575.2 5607.0 5607.6 5623.7 5623.9 3951.9 3955.4 3964.8 3966.1 3966.2 3904.2 3998.4 4000.5 4012.3 4032.9 4512.2 4515.7 4518.7 4544.4 4554.9 5319.8 5335.1 5346.3 5347.5 5361.6 1300.5 1308.5 1379.0 1394.7 1406.3 937.0 939.6 962.2 964.2 972.5 4657.0 4666.5 4668.9 4682.0 4687.7 5426.1 5445.2 5452.3 5460.3 5463.6 4548.6 4658.1 4665.2 4671.7 4675.9 2888.7 2928.3 2935.3 2936.0 2944.7 5141.1 5142.9 5152.3 5156.3 5163.0 5459.6 5599.9 5607.3 5613.6 5618.8 5124.3 5139.5 5147.1 5148.5 5168.8 5467.2 5467.9 5469.8 5470.6 5475.5 5194.8 5367.4 5367.8 5368.5 5376.2 5103.5 5122.7 5137.3 5140.9 5163.6 3908.8 3916.2 3918.9 3919.5 3926.1 5097.9 5268.6 5517.6 5537.6 5547.8 5354.5 5355.0 5369.0 5371.3 5376.3 5339.9 5370.1 5375.2 5376.4 5379.9 5128.4 5311.7 5314.0 5314.2 5325.9 5382.9 5400.2 5401.5 5405.3 5413.6 5074.6 5248.8 5259.9 5287.6 5287.8 05:40:44 INFO - PROCESS | 30865 | 05:40:44 INFO - PROCESS | 30865 | [#5] yui.html Cycles:180 Average:12265.23 Median:45994.54 stddev:14090.21 (30.6%) stddev-sans-first:14102.81 05:40:44 INFO - PROCESS | 30865 | Values: 665.9 721.7 733.5 745.1 780.7 11597.5 13083.2 13517.8 13558.8 13559.6 13525.3 13584.0 13611.6 13667.0 13831.2 628.1 778.5 795.6 797.9 798.0 760.1 795.3 795.6 797.2 797.6 820.8 825.1 826.3 826.3 827.0 655.7 794.3 826.0 826.4 827.0 596.5 596.5 596.6 597.0 597.5 12959.9 13011.0 13020.2 13020.7 13030.0 11009.6 11110.3 11265.9 11398.6 11526.7 10059.3 10060.7 10113.9 10157.4 10197.6 3226.1 3250.7 3296.7 3327.5 3357.5 46507.8 46931.5 47041.3 47048.1 47064.8 7984.0 8161.4 8164.0 8187.7 8587.7 14624.9 14700.9 14839.7 14841.9 14856.7 6424.9 6429.4 6484.3 6620.0 6711.9 3604.3 3685.6 3696.6 3704.2 3704.2 2950.7 2952.1 2985.5 2995.5 3000.2 471.4 521.3 533.4 539.6 548.9 385.3 535.1 541.4 572.6 577.7 7155.2 7259.5 7485.0 7686.3 7779.6 454.7 516.9 532.2 545.4 557.5 3628.9 3756.2 3757.5 3780.8 3880.1 50149.5 52422.5 52432.7 52497.2 52611.0 43877.3 44556.0 44619.0 44759.0 45481.3 41406.0 41641.0 41925.4 42368.6 42786.4 7032.4 7140.2 7297.2 7327.6 7390.8 26325.2 26377.3 26516.9 26994.0 27189.6 33275.5 33894.8 34404.7 35590.0 36196.0 9899.5 9973.2 10031.2 10040.4 10178.8 10054.3 10320.2 10589.5 10718.6 11068.4 10394.7 10444.4 10550.5 10555.9 11039.9 10036.3 10696.5 10747.4 10802.8 11205.4 9773.2 9792.6 9812.7 9903.3 10218.5 8874.1 9086.0 9092.1 9339.5 9449.5 8433.2 8442.2 8445.9 8624.0 8761.4 05:40:44 INFO - PROCESS | 30865 | -------- Summary: end -------- 05:40:44 INFO - PROCESS | 30865 | 05:40:45 INFO - TEST-INFO | 30865: exit 0 05:40:45 INFO - TEST-OK | dromaeo_css | took 1117590ms 05:40:45 INFO - TEST-START | kraken 05:40:45 INFO - operating with platform_type : linux_ 05:40:45 INFO - Initialising browser for kraken test... 05:40:45 INFO - TEST-INFO | started process 31040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg8zpeR/profile http://localhost:39798/getInfo.html) 05:40:49 INFO - PROCESS | 31040 | __metrics Screen width/height:1600/1200 05:40:49 INFO - PROCESS | 31040 | colorDepth:24 05:40:49 INFO - PROCESS | 31040 | Browser inner width/height: 1024/697 05:40:49 INFO - PROCESS | 31040 | __metrics 05:40:51 ERROR - PROCESS | 31040 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:40:51 INFO - TEST-INFO | 31040: exit 0 05:40:51 INFO - Browser initialized. 05:40:51 INFO - Running cycle 1/1 for kraken test... 05:40:51 INFO - TEST-INFO | started process 31119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg8zpeR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:03 INFO - PROCESS | 31119 | RSS: Main: 155328512 05:41:03 INFO - PROCESS | 31119 | 05:41:06 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:07 INFO - PROCESS | 31119 | RSS: Main: 210788352 05:41:07 INFO - PROCESS | 31119 | 05:41:10 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-dft) 05:41:10 INFO - PROCESS | 31119 | RSS: Main: 195919872 05:41:10 INFO - PROCESS | 31119 | 05:41:14 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-fft) 05:41:14 INFO - PROCESS | 31119 | RSS: Main: 267112448 05:41:14 INFO - PROCESS | 31119 | 05:41:16 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39798/tests/kraken/driver.html?testName=audio-oscillator) 05:41:17 INFO - PROCESS | 31119 | RSS: Main: 174387200 05:41:17 INFO - PROCESS | 31119 | 05:41:19 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:20 INFO - PROCESS | 31119 | RSS: Main: 178962432 05:41:20 INFO - PROCESS | 31119 | 05:41:23 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:24 INFO - PROCESS | 31119 | RSS: Main: 214753280 05:41:24 INFO - PROCESS | 31119 | 05:41:27 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39798/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:28 INFO - PROCESS | 31119 | RSS: Main: 213110784 05:41:28 INFO - PROCESS | 31119 | 05:41:31 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39798/tests/kraken/driver.html?testName=json-parse-financial) 05:41:31 INFO - PROCESS | 31119 | RSS: Main: 214343680 05:41:31 INFO - PROCESS | 31119 | 05:41:33 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:34 INFO - PROCESS | 31119 | RSS: Main: 201293824 05:41:34 INFO - PROCESS | 31119 | 05:41:35 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:36 INFO - PROCESS | 31119 | RSS: Main: 204148736 05:41:36 INFO - PROCESS | 31119 | 05:41:38 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:39 INFO - PROCESS | 31119 | RSS: Main: 218472448 05:41:39 INFO - PROCESS | 31119 | 05:41:42 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:42 INFO - PROCESS | 31119 | RSS: Main: 225120256 05:41:42 INFO - PROCESS | 31119 | 05:41:45 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:46 INFO - PROCESS | 31119 | RSS: Main: 220397568 05:41:46 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | Cycle 1(1): loaded http://localhost:39798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39798/tests/kraken/driver.html?testName=ai-astar) 05:41:48 INFO - PROCESS | 31119 | RSS: Main: 283828224 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | __start_tp_report 05:41:48 INFO - PROCESS | 31119 | _x_x_mozilla_page_load 05:41:48 INFO - PROCESS | 31119 | _x_x_mozilla_page_load_details 05:41:48 INFO - PROCESS | 31119 | |i|pagename|runs| 05:41:48 INFO - PROCESS | 31119 | |0;ai-astar;112;113;107;112;113;113;104;115;113;115 05:41:48 INFO - PROCESS | 31119 | |1;audio-beat-detection;167;131;159;179;134;162;155;140;192;132 05:41:48 INFO - PROCESS | 31119 | |2;audio-dft;160;161;162;160;162;161;163;162;162;162 05:41:48 INFO - PROCESS | 31119 | |3;audio-fft;75;77;122;117;75;74;76;102;99;74 05:41:48 INFO - PROCESS | 31119 | |4;audio-oscillator;94;94;156;93;95;93;151;93;93;150 05:41:48 INFO - PROCESS | 31119 | |5;imaging-gaussian-blur;117;117;117;119;117;117;118;118;117;117 05:41:48 INFO - PROCESS | 31119 | |6;imaging-darkroom;147;145;145;145;146;145;146;145;146;146 05:41:48 INFO - PROCESS | 31119 | |7;imaging-desaturate;94;95;95;95;95;94;94;94;95;95 05:41:48 INFO - PROCESS | 31119 | |8;json-parse-financial;65;64;65;64;66;67;69;80;63;61 05:41:48 INFO - PROCESS | 31119 | |9;json-stringify-tinderbox;65;64;64;64;64;64;65;70;65;64 05:41:48 INFO - PROCESS | 31119 | |10;stanford-crypto-aes;79;77;78;79;86;81;88;82;81;88 05:41:48 INFO - PROCESS | 31119 | |11;stanford-crypto-ccm;137;131;141;133;139;133;134;134;171;131 05:41:48 INFO - PROCESS | 31119 | |12;stanford-crypto-pbkdf2;185;173;179;180;187;179;177;182;178;172 05:41:48 INFO - PROCESS | 31119 | |13;stanford-crypto-sha256-iterative;74;74;73;80;73;74;72;74;73;71 05:41:48 INFO - PROCESS | 31119 | __end_tp_report 05:41:48 INFO - PROCESS | 31119 | __start_cc_report 05:41:48 INFO - PROCESS | 31119 | _x_x_mozilla_cycle_collect,1881 05:41:48 INFO - PROCESS | 31119 | __end_cc_report 05:41:48 INFO - PROCESS | 31119 | __startTimestamp1461588108508__endTimestamp 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | ------- Summary: start ------- 05:41:48 INFO - PROCESS | 31119 | Number of tests: 14 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:3.71 05:41:48 INFO - PROCESS | 31119 | Values: 112.0 113.0 107.0 112.0 113.0 113.0 104.0 115.0 113.0 115.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:160.50 stddev:20.88 (13.0%) stddev-sans-first:21.70 05:41:48 INFO - PROCESS | 31119 | Values: 167.0 131.0 159.0 179.0 134.0 162.0 155.0 140.0 192.0 132.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.87 05:41:48 INFO - PROCESS | 31119 | Values: 160.0 161.0 162.0 160.0 162.0 161.0 163.0 162.0 162.0 162.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.00 stddev:19.14 (25.5%) stddev-sans-first:19.61 05:41:48 INFO - PROCESS | 31119 | Values: 75.0 77.0 122.0 117.0 75.0 74.0 76.0 102.0 99.0 74.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:93.00 stddev:28.43 (30.6%) stddev-sans-first:29.47 05:41:48 INFO - PROCESS | 31119 | Values: 94.0 94.0 156.0 93.0 95.0 93.0 151.0 93.0 93.0 150.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:41:48 INFO - PROCESS | 31119 | Values: 117.0 117.0 117.0 119.0 117.0 117.0 118.0 118.0 117.0 117.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:41:48 INFO - PROCESS | 31119 | Values: 147.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:41:48 INFO - PROCESS | 31119 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.50 stddev:5.25 (8.0%) stddev-sans-first:5.55 05:41:48 INFO - PROCESS | 31119 | Values: 65.0 64.0 65.0 64.0 66.0 67.0 69.0 80.0 63.0 61.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:1.85 (2.9%) stddev-sans-first:1.96 05:41:48 INFO - PROCESS | 31119 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 65.0 70.0 65.0 64.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:4.07 (5.0%) stddev-sans-first:4.18 05:41:48 INFO - PROCESS | 31119 | Values: 79.0 77.0 78.0 79.0 86.0 81.0 88.0 82.0 81.0 88.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:135.50 stddev:11.92 (8.8%) stddev-sans-first:12.63 05:41:48 INFO - PROCESS | 31119 | Values: 137.0 131.0 141.0 133.0 139.0 133.0 134.0 134.0 171.0 131.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:179.50 stddev:4.71 (2.6%) stddev-sans-first:4.50 05:41:48 INFO - PROCESS | 31119 | Values: 185.0 173.0 179.0 180.0 187.0 179.0 177.0 182.0 178.0 172.0 05:41:48 INFO - PROCESS | 31119 | 05:41:48 INFO - PROCESS | 31119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:2.39 (3.2%) stddev-sans-first:2.54 05:41:48 INFO - PROCESS | 31119 | Values: 74.0 74.0 73.0 80.0 73.0 74.0 72.0 74.0 73.0 71.0 05:41:48 INFO - PROCESS | 31119 | -------- Summary: end -------- 05:41:48 INFO - PROCESS | 31119 | 05:41:49 INFO - TEST-INFO | 31119: exit 0 05:41:49 INFO - TEST-OK | kraken | took 63859ms 05:41:49 INFO - SUITE-END | took 1181s 05:41:49 INFO - Completed test suite (00:19:41) 05:41:49 INFO - javascript benchmark 05:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.0055428659966, 2693.133900867213, 2693.9191824245254, 2698.123109989254, 2700.6894207166183, 4523.163214805255, 4607.940173760037, 4696.319033740106, 4697.0, 4720.527947205278, 4700.623950083994, 4719.693219940701, 4766.809327626891, 4806.0628177505405, 4806.447258565266, 4309.922519370165, 4324.329728892027, 4374.934375984363, 4389.144116897206, 4448.132614140244, 4326.242907491192, 4358.106588149421, 4440.023194897118, 4466.039801442689, 4469.486009108945, 4237.194932962727, 4371.191329604034, 4404.4494438195225, 4420.425344705168, 4423.115376924612, 4238.766867822269, 4248.086661367821, 4275.5724427557, 4280.72175308604, 4340.8697739067875, 4305.827766889321, 4336.739795612273, 4340.370646256307, 4374.147041326943, 4393.033532622818, 4535.342375355555, 4608.28571571407, 4618.284165954283, 4618.953810461886, 4636.652251081183, 5052.216906379517, 5087.236914462823, 5098.388193416777, 5142.331496905415, 5155.61332900034, 5049.242613607951, 5074.847754567332, 5076.23856421536, 5087.49125087492, 5134.64057515974, 4604.7927843247135, 4707.29390591414, 4720.3863497745415, 4740.6681532292405, 4741.170295198326, 5133.153029750049, 5142.537171654494, 5164.14791559396, 5172.379314482287, 5213.869653258699, 4949.282354058713, 4957.82647607332, 4958.1323268428605, 4961.231009193581, 5002.0, 4909.4354149273295, 5030.471800460972, 5033.84898453047, 5034.622403319766, 5120.539151476385, 5025.47232540578, 5049.368828896388, 5060.974695126501, 5061.063703214917, 5062.240663900371, 5030.673006254582, 5031.6729412588065, 5032.0, 5035.471275516018, 5066.16408292635, 4159.126583417456, 4225.7887105644595, 4244.129953359554, 4299.355096735515, 4320.740755554677, 3685.8709945152327, 3701.9074523137137, 3705.5738590061947, 3742.139307959185, 3753.0429740416566, 4302.354646802942, 4303.483581970184, 4308.052228509723, 4350.151720414488, 4355.259605867011, 4929.309896614477, 4974.353334066621, 5027.4469808321055, 5065.822696205615, 5071.137906555894, 4234.978825105916, 4247.575242475789, 4256.233877901946, 4278.807453664593, 4292.377605247221, 4439.134368798053, 4439.356293337448, 4444.155610434007, 4484.461864576207, 4492.124035813051, 4614.284785858197, 4718.457377401643, 4787.281907713871, 4807.735574543433, 4820.855374338776, 5066.594672426123, 5088.185890257541, 5104.259882317117, 5113.849383888595, 5157.226416037624, 4589.5639914208095, 4773.689710168828, 4800.423949126127, 4802.423709154924, 4852.587530059985, 4909.26361045846, 4971.130052240916, 4982.451930287593, 4983.25251212321, 4986.501349864984, 4969.428515720739, 5030.044291584587, 5032.949670503248, 5035.546800787946, 5062.417821950523, 4811.109944660249, 4869.415670119608, 4871.244957031666, 4871.464138944642, 4918.262260660929, 4751.382320298478, 4895.975520122377, 4942.283368911416, 4974.651774375759, 4992.950070499249, 4806.062817750645, 4810.7113573185725, 4820.68665536739, 4827.444843843003, 4850.927236091532, 4804.663673542818, 4923.950760492349, 4929.975350123226, 4931.211006239128, 4975.477574854588, 4754.096721622881, 4823.517648235148, 4832.661713680009, 4868.513148685103, 4873.122837889214], "value": 4623.541586383763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7199686155353, 583.9065749480084, 592.3277080513617, 600.4175949329149, 609.9329073801882, 34296.828515857414, 35435.645643543525, 35440.64559354405, 35505.206797082385, 35575.28849423013, 36846.8157659212, 37697.43453848187, 37709.622903770956, 37740.24519509615, 37772.0, 7616.314531692133, 7806.1413244543055, 7813.726519571816, 7819.452638315321, 7820.100688420819, 7567.848643027136, 7693.230676932318, 7704.422168337369, 7704.998350214464, 7707.499012564165, 7792.298693117618, 7855.93944817448, 7856.2536559027085, 7857.882131768028, 7861.724839630586, 7776.844463110734, 7815.296623303873, 7830.6084695764985, 7836.373090152774, 7841.764747057598, 7696.807579810494, 7774.067111946546, 7781.688732450695, 7950.204979502061, 7958.084820245688, 36948.630513695054, 37379.439308410394, 37438.8128059358, 37493.437598436045, 37523.4371484428, 2705.8105932584726, 2981.8956336528117, 3358.177246574605, 3436.810975396352, 3535.7701749386465, 27024.864875675692, 28625.713742862514, 28638.856805715837, 28944.27639309013, 29367.55948660772, 3495.598006229265, 3498.1079824644808, 3527.1005893496995, 3559.341521818446, 3634.9818250908843, 233760.0, 235193.0, 235762.99999999828, 235817.0, 236638.0, 48513.75743121332, 49614.50385496171, 49728.75135624299, 49737.502624973284, 49738.75130624396, 57226.0, 58647.0, 58707.119393209134, 58712.41287587155, 58773.0, 13427.26150061756, 13629.659258518419, 13640.93179534116, 13642.658933526543, 13658.590242292747, 9159.175674189222, 9173.40372875761, 9188.0, 9192.908070919339, 9198.908010919939, 17557.824421755875, 17662.381816636356, 17753.201105950262, 18265.45203643893, 18329.90835045816, 6581.80254592363, 6800.795976120724, 6904.344087311697, 6951.443884489228, 6979.581225126509, 839.7648658375665, 873.4977388001925, 931.1293940165831, 984.414273507262, 992.0971915556809, 26263.606045909328, 27477.17568472949, 28032.159035228975, 28047.615952643846, 28053.0, 934.3926447808979, 937.4188003437775, 961.3943215774018, 1038.8597539332093, 1054.8312270036756, 14450.060746051473, 14870.925645371704, 14899.47851825181, 15080.698386032438, 15197.848021519865, 342956.0, 347927.0, 351513.0, 351547.0, 352252.0, 46537.53462465332, 48035.27947080797, 48190.0, 48197.0, 48223.5177648226, 1160.5067846165514, 1203.4043148641479, 1219.603628820637, 1225.40567824605, 1240.5658019693215, 26172.083977060713, 26969.595456067782, 27035.0, 27271.454570908867, 27297.72702272952, 41688.0, 42060.57939420689, 42181.367279490216, 42272.0, 42323.0, 254117.0, 254304.0, 254440.0, 254637.0, 255060.0, 24838.254852354457, 25425.237242882744, 39409.60590394174, 40857.59142408657, 40957.590424095375, 39335.213295734495, 39685.0, 40287.1942561153, 40372.79813600913, 40605.0, 34506.482402763475, 34910.301793964485, 35196.0, 35360.82319588386, 35561.46657800187, 33741.49387759136, 34410.0, 34597.30805383828, 34689.47965780465, 34730.82634586811, 28388.43223135567, 33445.33109337848, 33783.3243335127, 34109.317813644084, 37063.81468092642, 27437.868497649397, 28546.0, 29256.0, 29553.26116847096, 29745.0, 24474.63288050645, 25537.74462255428, 25538.74461255438, 25743.227703168934, 26555.486843942967], "value": 17117.97862733767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.16553664705964, 381.715621861713, 384.50975006866224, 387.13282247765, 398.936170212766, 15630.452934147306, 16656.250468728907, 16757.41349052782, 16775.412860549884, 16788.58028549287, 10256.794864102732, 10724.78550428991, 10751.784964300708, 10760.192985526077, 10784.514696838642, 4620.676552641316, 4722.90554188916, 4772.0, 4773.0, 4796.640251981098, 4580.633549316063, 4740.834070807522, 4747.121782470237, 4752.928706069411, 4758.072175925696, 4726.480087190406, 4756.381670382845, 4768.833090841821, 4769.260764581495, 4809.086273608021, 4676.415448068991, 4772.236442169271, 4781.617470602343, 4806.086843499724, 4808.3989501312335, 4680.9297860532115, 4690.788914498856, 4691.7654117294, 4697.835575754866, 5014.323066386064, 12196.207246528948, 12196.878031219752, 12388.194767340094, 12395.318257495834, 12414.503419863195, 1890.4423195157324, 1933.4779609505356, 1942.2619404626294, 1944.2903340280836, 2004.0681083296192, 9111.863322050174, 9249.35254532183, 9638.373505722106, 11515.769684606345, 13458.088432070208, 1696.457133717211, 1749.0297025751472, 1809.7918739345012, 1839.9724004139814, 1848.7504186934725, 71018.0, 71543.6422817893, 71856.64071679609, 72205.0, 72372.0, 9984.450855203033, 10115.797684046278, 10403.635872744419, 10472.266941314036, 10554.2084343673, 14255.64360890986, 14338.992541044263, 14378.856211437751, 14424.927875360556, 14466.566003019927, 7019.4735394844565, 7070.6919219944475, 7121.9643901780155, 7129.679164437613, 7143.535670181422, 6700.195976482853, 6707.094542236736, 6746.359095885883, 6874.312568743086, 6876.243613202544, 4477.686561940698, 4482.887927801831, 4501.549845015472, 4511.210538155809, 4551.3173024046, 1844.9446516604523, 1890.1588792986988, 1904.6095550412133, 1917.4918646558674, 1918.098493707955, 808.6644042722204, 847.7541512961295, 894.3739382432193, 950.3062764182185, 957.6648173139346, 16295.59261018484, 16522.75215871763, 16625.91687041557, 16669.749953750703, 17096.91451542759, 872.3675335381797, 891.9063498332712, 902.4269588811021, 926.4672813132476, 958.7794807194384, 9044.41211321262, 9493.572789224501, 9496.572654230577, 9499.762505937408, 9627.0, 376624.0, 388921.0, 394954.0, 396927.0, 404882.0, 68105.0, 81712.18287817165, 82032.0, 84307.0, 86587.13412865916, 907.4782000349693, 916.0518862976787, 921.0, 924.12670026824, 926.4487629860357, 14585.343659535134, 14713.55859324222, 14762.926185369004, 14769.187694676895, 14787.260636967894, 33500.83249583736, 34239.14402139966, 34383.48424773681, 34550.13624659403, 35105.0, 42737.52930531915, 44781.77609111933, 46796.29805552988, 47180.80114406465, 49199.75400122976, 7522.774316770506, 7778.183290754389, 7794.493357931717, 7807.687692492236, 7910.802229944297, 8730.956345218234, 11189.272697274651, 11220.382878941737, 12003.099767517297, 12063.336516491678, 10170.135538479311, 10211.693649190536, 10316.071553560216, 10519.0, 10622.628208012682, 9853.113219810251, 9891.55488003056, 10044.849327259952, 10156.898431015596, 10467.895321046692, 9950.800983980425, 10035.09684128432, 10180.694579162637, 10352.378857268588, 10464.37213767146, 7482.925170748223, 7574.81062973408, 7610.200928902385, 7637.809054773675, 7814.257645523666, 9086.363954523384, 9534.380265283013, 9785.0, 9831.262655300738, 9892.851607225753], "value": 7881.672133343413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.1847780464896, 1459.5037687186357, 1462.1446453824512, 1621.0, 1787.6603445345393, 6883.79348619541, 7121.679524421401, 7759.534427934328, 7977.242161994615, 7992.080910695272, 7776.066871975357, 7777.18339574345, 7790.220977902207, 7856.882146767803, 7864.882026769603, 2226.8997895094717, 2282.4978504728933, 2283.4519715268298, 2286.4626812699003, 2290.7823756743164, 2226.6882636430914, 2246.550689862026, 2262.049939025613, 2282.1441959265276, 2285.9771402285933, 2260.2880092770724, 2269.6028195065796, 2272.6363781794917, 2313.9652905206435, 2317.2121478697322, 2234.3297010896667, 2247.0, 2258.2096266306826, 2260.0, 2261.683364328995, 2194.7585765565773, 2207.381933058746, 2210.458437682778, 2212.0930418528487, 2214.8228141748623, 7784.3772498200005, 7870.0949390820215, 7903.446758726834, 7907.169747176578, 7918.881216781753, 4622.560856718606, 4761.285807128924, 4765.857024289242, 4774.188387974053, 4791.329213910055, 2901.376204116104, 2932.8680209390627, 2959.201015725742, 2960.0379876539996, 2961.2596850787304, 932.5290728182292, 945.6170251048336, 951.1202138022371, 966.917811985982, 974.1622204903778, 10466.215033872413, 10872.402017888933, 10976.506057227363, 11019.724506887393, 11024.0, 4103.302438585448, 4275.593818587229, 4355.825766969286, 4358.171947329997, 4370.322599996942, 8270.172982701803, 8376.790580235544, 8377.329813614897, 8396.0, 8431.662733490592, 4677.041206552649, 4687.156311863897, 4687.6249900007915, 4711.882202944954, 4720.929186062212, 3693.261347730465, 3817.9045523862123, 4154.522229943595, 4297.914041719148, 4335.371371151228, 3390.338883917662, 3431.3995050866497, 3512.7014203792965, 3525.4183059794846, 3526.118470382404, 1037.180627304436, 1084.4252546150553, 1089.0851684584986, 1101.801675698366, 1102.6251074634663, 700.6916956539106, 797.6889013284823, 819.3445243805052, 821.1131977464324, 826.7891687619618, 4842.951570484321, 5063.1269672617655, 5086.9745651271505, 5190.221466779938, 5231.555317797954, 862.1335557764532, 887.316766090107, 899.5007770687331, 912.5026860361119, 914.2320450821342, 3311.106001379614, 3410.36908171989, 3412.6587341265677, 3443.2252743132594, 3484.3902317094407, 9573.664921727706, 9868.703938881845, 9901.900980990242, 9963.402195868272, 9982.201423886072, 9757.316987810786, 9828.508574571242, 9836.704898853046, 9916.702498925044, 9917.702468925943, 7481.513701609378, 7628.199039100926, 7643.464957453036, 7658.195889431641, 7662.923370766221, 4856.271559266138, 4990.900181996267, 4996.825111121093, 5061.367329083864, 5112.105381558287, 9155.038720934472, 9194.402363846597, 9204.447733136034, 9366.250699943852, 9376.671816486663, 8808.779780505538, 9039.864402034107, 9149.679761208326, 9170.403923744936, 9343.34596578233, 6044.184035155374, 6525.64108974011, 6541.247756508063, 6685.832854178684, 6778.96610516964, 7273.527220730635, 7301.160366557914, 7356.521826081287, 7368.778936631909, 7380.446466514925, 6372.107904893226, 6600.339966003361, 6640.634765087966, 6733.124693789776, 6747.257801641914, 6533.314002029719, 6614.206295244601, 6630.436412904957, 6632.535722499379, 6636.834079147867, 6189.257289125154, 6221.688915554295, 6255.24937007562, 6270.0, 6270.310265870659, 4401.229784787585, 4465.553444655508, 4653.069386122721, 4721.173794586002, 4722.716637001791, 4538.500764915922, 4580.541945805393, 4679.649026322972, 4689.484156742824, 4700.9529904701885], "value": 4140.981320169743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.49064025638205, 315.20568168216096, 321.41342050757373, 325.15459804508293, 328.4268950681062, 4927.950720492794, 5042.688900885769, 5099.4390617032095, 5127.897442051157, 5134.717590532519, 4833.4441539223, 5033.245013248005, 5050.646454748169, 5050.974745126278, 5094.439611642716, 3994.2810294147116, 4007.3788562772816, 4009.0578714002186, 4016.4577781999496, 4016.513889860741, 3774.6602805747475, 3839.0978120141745, 3996.7601943883315, 4007.6793856491413, 4017.8191981360765, 3958.129211573449, 3976.324024915771, 3990.4413382126527, 3994.6005399460114, 3997.5202975642965, 3956.7823769692654, 3964.940525892114, 3970.900727481836, 3973.3642617181113, 3977.76133431995, 3457.4468085106264, 3525.94711079334, 3529.523514325559, 3532.5054492371087, 3541.220931395089, 4818.71087734737, 4823.348847905523, 4826.251930950708, 4838.491958344393, 4842.370491836074, 4548.658145846983, 4560.315952607102, 4565.977170114162, 4569.634429245652, 4572.4910779443035, 5179.249008893689, 5308.681479111266, 5309.486796263085, 5312.1766126250495, 5332.466753324637, 3796.6013568575177, 3841.4621952926614, 3845.5000849889616, 3849.345611246095, 3862.6909847212155, 5575.2473416088715, 5606.971965140148, 5607.551395888319, 5623.718814059281, 5623.9437605623825, 3951.881443556698, 3955.4264631628253, 3964.7621142731527, 3966.127451960564, 3966.2067586482817, 3904.1801221743185, 3998.3802510610903, 4000.5399379071196, 4012.257732319472, 4032.8991775205855, 4512.210363186429, 4515.68390212682, 4518.6611004174165, 4544.386507821402, 4554.908901821945, 5319.840404787863, 5335.10603735676, 5346.331708536433, 5347.465253474699, 5361.597880159004, 1300.518808041031, 1308.5093090091216, 1379.0, 1394.7489451898755, 1406.2757679794913, 936.9718908432758, 939.5912777941618, 962.2206013129388, 964.1611797735875, 972.4554249620236, 4657.0, 4666.4633567139535, 4668.929966050512, 4681.95318046822, 4687.695299805502, 5426.077566813651, 5445.156000819879, 5452.291202143696, 5460.34475862891, 5463.644863083887, 4548.56788605082, 4658.091672123904, 4665.183592871234, 4671.696339737906, 4675.906481870344, 2888.6966868478507, 2928.282570770132, 2935.2661834541364, 2935.955960660549, 2944.7349738523635, 5141.126008578551, 5142.922856157161, 5152.252923326172, 5156.329677142023, 5162.97418512905, 5459.590530710213, 5599.860003499945, 5607.271054762855, 5613.550915926716, 5618.775248989995, 5124.333836601292, 5139.483852263516, 5147.099257629975, 5148.459411761786, 5168.8449346519665, 5467.152591348347, 5467.890642187213, 5469.835904922858, 5470.562355011669, 5475.479829416199, 5194.818181363634, 5367.382750983531, 5367.838964831061, 5368.543673787772, 5376.166694162411, 5103.540681338697, 5122.718250496109, 5137.280780690631, 5140.897182056413, 5163.586913047023, 3908.843646254118, 3916.2167566487387, 3918.9216215676097, 3919.5296564411315, 3926.1362500249897, 5097.92353114711, 5268.550124192269, 5517.613767036269, 5537.612367134262, 5547.805826796042, 5354.46455354477, 5354.973225134006, 5369.0, 5371.274877891435, 5376.327959005124, 5339.893202136013, 5370.087085195448, 5375.247465354775, 5376.408595054619, 5379.946200537945, 5128.410232823124, 5311.734413279243, 5314.0, 5314.202869569595, 5325.946740532545, 5382.919256211082, 5400.2439658447065, 5401.513863752281, 5405.297311349499, 5413.593980451561, 5074.644774865724, 5248.763805628832, 5259.868503287448, 5287.64699708626, 5287.762050707651], "value": 4030.2009269667165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.943394811441, 721.732958805242, 733.537871141181, 745.128200005993, 780.7462574663236, 11597.536098556058, 13083.215007099569, 13517.797233041487, 13558.796618050737, 13559.593212203637, 13525.256110913895, 13583.981201409884, 13611.591652250423, 13667.0, 13831.239281839495, 628.0704557255265, 778.5250996891891, 795.6300320351036, 797.8763291689797, 798.0264077825044, 760.1182628151346, 795.3120550723611, 795.6220795122329, 797.1948332184506, 797.6251161953872, 820.782492639451, 825.1006403020706, 826.3471857232779, 826.3471857232809, 827.0158511371449, 655.7180412422656, 794.2613369566301, 826.0459169659053, 826.4215049465398, 826.9875951860727, 596.4602035158189, 596.5198015597442, 596.5645079092287, 596.9850753731148, 597.5458651424905, 12959.87040129596, 13011.0, 13020.153690010215, 13020.739585208337, 13030.0, 11009.61466348674, 11110.277831940979, 11265.943670281596, 11398.60104896333, 11526.654200374001, 10059.295849290553, 10060.698179054567, 10113.89886101137, 10157.39055656663, 10197.643082492077, 3226.1128189748006, 3250.658680838525, 3296.653851345622, 3327.4842399428126, 3357.5131605917004, 46507.767461162475, 46931.530684693054, 47041.29438058432, 47048.059038819374, 47064.7646761764, 7983.960080199562, 8161.387895907831, 8163.959180204061, 8187.672493100328, 8587.742367728979, 14624.926875365554, 14700.926495367456, 14839.70320593582, 14841.851581484047, 14856.702865942621, 6424.903626445607, 6429.38920802523, 6484.286728459866, 6620.0, 6711.865762684719, 3604.279144171176, 3685.5577330720484, 3696.611855755161, 3704.1665625234104, 3704.1850792825535, 2950.749186319144, 2952.070097919149, 2985.477541430241, 2995.5207166853197, 3000.189948713835, 471.41779901821224, 521.3092652235803, 533.4185737546094, 539.635745871543, 548.8682716148176, 385.3064483928917, 535.1277417808947, 541.3638974205293, 572.5562688916124, 577.7342422485704, 7155.248698886542, 7259.491835571459, 7484.951324035726, 7686.308232259012, 7779.572123533147, 454.7339806213336, 516.8578640873715, 532.2335836395578, 545.3987547883218, 557.5066066531149, 3628.872989445357, 3756.192418629953, 3757.4739536464917, 3780.8109594520715, 3880.1269714314053, 50149.49850501521, 52422.47577524176, 52432.737836310574, 52497.2125418119, 52611.0, 43877.341839872424, 44556.0, 44619.0, 44759.0, 45481.31778023332, 41405.9961305603, 41641.0, 41925.371119433235, 42368.57631423646, 42786.35820462696, 7032.437405007689, 7140.158294555136, 7297.160826504807, 7327.596982165819, 7390.778276651709, 26325.21024369272, 26377.340566485993, 26516.867415662797, 26994.0, 27189.59215611728, 33275.50086748749, 33894.8305258482, 34404.655953440146, 35590.0, 36196.0, 9899.505024748878, 9973.152282056106, 10031.247656425652, 10040.397576145455, 10178.796424071625, 10054.29619926598, 10320.174386049248, 10589.470526473491, 10718.571257149939, 11068.446577671246, 10394.688159355232, 10444.42555659446, 10550.472476375997, 10555.94722026385, 11039.944800275947, 10036.297459177787, 10696.518656660313, 10747.408892510673, 10802.783944321227, 11205.43972801373, 9773.218142548436, 9792.608295668093, 9812.705618831447, 9903.306768526134, 10218.54016569271, 8874.112588741074, 9086.0, 9092.090011591106, 9339.53302334867, 9449.527523623654, 8433.19884610961, 8442.15578442151, 8445.873311900203, 8623.969562460208, 8761.386702930733], "value": 5684.374782025153, "unit": "score"}], "name": "dromaeo_css", "value": 6242.6269568917405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 112.0, 113.0, 113.0, 104.0, 115.0, 113.0, 115.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 159.0, 179.0, 134.0, 162.0, 155.0, 140.0, 192.0, 132.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 122.0, 117.0, 75.0, 74.0, 76.0, 102.0, 99.0, 74.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 156.0, 93.0, 95.0, 93.0, 151.0, 93.0, 93.0, 150.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 67.0, 69.0, 80.0, 63.0, 61.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 70.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 79.0, 86.0, 81.0, 88.0, 82.0, 81.0, 88.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 141.0, 133.0, 139.0, 133.0, 134.0, 134.0, 171.0, 131.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 173.0, 179.0, 180.0, 187.0, 179.0, 177.0, 182.0, 178.0, 172.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 80.0, 73.0, 74.0, 72.0, 74.0, 73.0, 71.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1590.8000000000004, "alertThreshold": 2.0}]} 05:41:49 INFO - Return code: 0 05:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:49 ERROR - # TBPL SUCCESS # 05:41:49 INFO - Running post-action listener: _resource_record_post_action 05:41:49 INFO - Running post-run listener: _resource_record_post_run 05:41:50 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517492736; Read time: 24; Write time: 410524 05:41:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 197287936; Read time: 0; Write time: 199176 05:41:50 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283095040; Read time: 24; Write time: 198316 05:41:50 INFO - Running post-run listener: _upload_blobber_files 05:41:50 INFO - Blob upload gear active. 05:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:50 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:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:52 INFO - (blobuploader) - INFO - Done attempting. 05:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:53 INFO - (blobuploader) - INFO - Done attempting. 05:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:53 INFO - Return code: 0 05:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b854eaa32ea15aabf6b89fc4e254ed7ad08536cf6689fcea443a492bb04004b87f8c69262db40221eda32e7dfc8346a2674946e283d8bf1caaef6086abcd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d32c519b14d42fec05122a53b26ef1e6b1d8c2cb7aa775901c7f82fceb84fb948a0c5f76a4e8397899641181605d425128de043ea851e87bc1135def19a628e7"} 05:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:53 INFO - Contents: 05:41:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b854eaa32ea15aabf6b89fc4e254ed7ad08536cf6689fcea443a492bb04004b87f8c69262db40221eda32e7dfc8346a2674946e283d8bf1caaef6086abcd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d32c519b14d42fec05122a53b26ef1e6b1d8c2cb7aa775901c7f82fceb84fb948a0c5f76a4e8397899641181605d425128de043ea851e87bc1135def19a628e7"} 05:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:53 INFO - Copying logs to upload dir... 05:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.807683 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-25 05:41:52.948601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:52.952076) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b854eaa32ea15aabf6b89fc4e254ed7ad08536cf6689fcea443a492bb04004b87f8c69262db40221eda32e7dfc8346a2674946e283d8bf1caaef6086abcd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d32c519b14d42fec05122a53b26ef1e6b1d8c2cb7aa775901c7f82fceb84fb948a0c5f76a4e8397899641181605d425128de043ea851e87bc1135def19a628e7"} build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c6b854eaa32ea15aabf6b89fc4e254ed7ad08536cf6689fcea443a492bb04004b87f8c69262db40221eda32e7dfc8346a2674946e283d8bf1caaef6086abcd64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d32c519b14d42fec05122a53b26ef1e6b1d8c2cb7aa775901c7f82fceb84fb948a0c5f76a4e8397899641181605d425128de043ea851e87bc1135def19a628e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:52.976827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:52.977165) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1461586872.946478-1024073400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:53.062827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:41:53.063140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:41:53.063418) ========= ========= Total master_lag: 0.18 =========