builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1461586868.99 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:08.987653) ========= 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:08.988398) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:08.988922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:09.005554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:09.005962) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 05:21:09-- 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% 27.8M=0s 2016-04-25 05:21:09 (27.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:09.095378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:09.095856) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016807 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:09.148453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:21:09.149285) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 05:21:09,719 truncating revision to first 12 chars 2016-04-25 05:21:09,719 Setting DEBUG logging. 2016-04-25 05:21:09,719 attempt 1/10 2016-04-25 05:21:09,719 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:10,717 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.298998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:21:10.462356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:10.462759) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:10.463247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:10.463521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:21:10.472947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-25 05:21:10.473307) ========= /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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:11 INFO - MultiFileLogger online at 20160425 05:21:11 in /builds/slave/test 05:21:11 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:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:11 INFO - {'append_to_log': False, 05:21:11 INFO - 'base_work_dir': '/builds/slave/test', 05:21:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:11 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:11 INFO - 'config_files': ('talos/linux_config.py',), 05:21:11 INFO - 'default_actions': ('clobber', 05:21:11 INFO - 'read-buildbot-config', 05:21:11 INFO - 'download-and-extract', 05:21:11 INFO - 'populate-webroot', 05:21:11 INFO - 'create-virtualenv', 05:21:11 INFO - 'install', 05:21:11 INFO - 'run-tests'), 05:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:11 INFO - 'download_minidump_stackwalk': True, 05:21:11 INFO - 'download_symbols': 'ondemand', 05:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:11 INFO - 'installer_path': 'installer.exe', 05:21:11 INFO - 'log_level': 'info', 05:21:11 INFO - 'log_name': 'talos', 05:21:11 INFO - 'log_to_console': True, 05:21:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:11 INFO - 'opt_config_files': (), 05:21:11 INFO - 'pip_index': False, 05:21:11 INFO - 'sps_profile': False, 05:21:11 INFO - 'sps_profile_interval': 0, 05:21:11 INFO - 'suite': 'dromaeojs', 05:21:11 INFO - 'system_bits': '32', 05:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:11 INFO - 'title': 'talos-linux64-ix-023', 05:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:11 INFO - 'use_talos_json': True, 05:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:11 INFO - 'work_dir': 'build'} 05:21:11 INFO - ##### 05:21:11 INFO - ##### Running clobber step. 05:21:11 INFO - ##### 05:21:11 INFO - Running pre-action listener: _resource_record_pre_action 05:21:11 INFO - Running main action method: clobber 05:21:11 INFO - rmtree: /builds/slave/test/build 05:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:12 INFO - Running post-action listener: _resource_record_post_action 05:21:12 INFO - ##### 05:21:12 INFO - ##### Running read-buildbot-config step. 05:21:12 INFO - ##### 05:21:12 INFO - Running pre-action listener: _resource_record_pre_action 05:21:12 INFO - Running main action method: read_buildbot_config 05:21:12 INFO - Using buildbot properties: 05:21:12 INFO - { 05:21:12 INFO - "project": "", 05:21:12 INFO - "product": "firefox", 05:21:12 INFO - "script_repo_revision": "production", 05:21:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:12 INFO - "repository": "", 05:21:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:21:12 INFO - "buildid": "20160422035423", 05:21:12 INFO - "pgo_build": "False", 05:21:12 INFO - "basedir": "/builds/slave/test", 05:21:12 INFO - "buildnumber": 1706, 05:21:12 INFO - "slavename": "talos-linux64-ix-023", 05:21:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:21:12 INFO - "platform": "ubuntu64_hw", 05:21:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:12 INFO - "branch": "fx-team", 05:21:12 INFO - "repo_path": "integration/fx-team", 05:21:12 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:21:12 INFO - "stage_platform": "linux64", 05:21:12 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:21:12 INFO - "slavebuilddir": "test" 05:21:12 INFO - } 05:21:12 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:12 INFO - Running post-action listener: _resource_record_post_action 05:21:12 INFO - ##### 05:21:12 INFO - ##### Running download-and-extract step. 05:21:12 INFO - ##### 05:21:12 INFO - Running pre-action listener: _resource_record_pre_action 05:21:12 INFO - Running main action method: download_and_extract 05:21:12 INFO - mkdir: /builds/slave/test/build/tests 05:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloaded 1361 bytes. 05:21:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:21:12 INFO - Using the following test package requirements: 05:21:12 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'jsshell-linux-x86_64.zip'], 05:21:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:12 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:12 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:12 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:12 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:12 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:12 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:13 INFO - Downloaded 22281373 bytes. 05:21:13 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:13 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:15 INFO - Return code: 0 05:21:15 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: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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:21:15 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:16 INFO - Downloaded 22281373 bytes. 05:21:16 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:16 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:17 INFO - Return code: 0 05:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 10845952 bytes. 05:21:18 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:18 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:18 INFO - Return code: 0 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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:21:18 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:19 INFO - Downloaded 54649298 bytes. 05:21:19 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:19 INFO - mkdir: /builds/slave/test/properties 05:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:19 INFO - Contents: 05:21:19 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:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - Running post-action listener: set_extra_try_arguments 05:21:20 INFO - ##### 05:21:20 INFO - ##### Running populate-webroot step. 05:21:20 INFO - ##### 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: populate_webroot 05:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:20 INFO - '--tppagecycles', 05:21:20 INFO - '7'], 05:21:20 INFO - 'tests': ['tsvgm']}}, 05:21:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['damp', 'tps']}, 05:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['damp', 'tps']}, 05:21:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['dromaeo_dom']}, 05:21:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['tsvgx', 05:21:20 INFO - 'tsvgr_opacity', 05:21:20 INFO - 'tart', 05:21:20 INFO - 'tscrollx', 05:21:20 INFO - 'cart']}, 05:21:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:20 INFO - 'tsvgr_opacity', 05:21:20 INFO - 'tart', 05:21:20 INFO - 'tscrollx', 05:21:20 INFO - 'cart']}, 05:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--disable-e10s'], 05:21:20 INFO - 'tests': ['tp5o']}, 05:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['tp5o']}, 05:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--disable-e10s', 05:21:20 INFO - '--xperf_path', 05:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:20 INFO - 'tests': ['tp5n']}, 05:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--xperf_path', 05:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:20 INFO - 'tests': ['tp5n']}}, 05:21:20 INFO - 'talos.zip': {'path': '', 05:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - ##### 05:21:20 INFO - ##### Running create-virtualenv step. 05:21:20 INFO - ##### 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: create_virtualenv 05:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:20 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:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:20 INFO - Using real prefix '/usr' 05:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:23 INFO - Installing pip.................done. 05:21:23 INFO - Return code: 0 05:21:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:23 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 05:21:23 INFO - 'HOME': '/home/cltbld', 05:21:23 INFO - 'LANG': 'en_US.UTF-8', 05:21:23 INFO - 'LANGUAGE': 'en_US:en', 05:21:23 INFO - 'LOGNAME': 'cltbld', 05:21:23 INFO - 'MAIL': '/var/mail/cltbld', 05:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:23 INFO - 'MOZ_NO_REMOTE': '1', 05:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:23 INFO - 'NO_EM_RESTART': '1', 05:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:23 INFO - 'PWD': '/builds/slave/test', 05:21:23 INFO - 'SHELL': '/bin/bash', 05:21:23 INFO - 'SHLVL': '1', 05:21:23 INFO - 'TERM': 'linux', 05:21:23 INFO - 'TMOUT': '86400', 05:21:23 INFO - 'USER': 'cltbld', 05:21:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:23 INFO - '_': '/tools/buildbot/bin/python'} 05:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:23 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:23 INFO - Cleaning up... 05:21:23 INFO - Return code: 0 05:21:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:23 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 05:21:23 INFO - 'HOME': '/home/cltbld', 05:21:23 INFO - 'LANG': 'en_US.UTF-8', 05:21:23 INFO - 'LANGUAGE': 'en_US:en', 05:21:23 INFO - 'LOGNAME': 'cltbld', 05:21:23 INFO - 'MAIL': '/var/mail/cltbld', 05:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:23 INFO - 'MOZ_NO_REMOTE': '1', 05:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:23 INFO - 'NO_EM_RESTART': '1', 05:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:23 INFO - 'PWD': '/builds/slave/test', 05:21:23 INFO - 'SHELL': '/bin/bash', 05:21:23 INFO - 'SHLVL': '1', 05:21:23 INFO - 'TERM': 'linux', 05:21:23 INFO - 'TMOUT': '86400', 05:21:23 INFO - 'USER': 'cltbld', 05:21:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:23 INFO - '_': '/tools/buildbot/bin/python'} 05:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:23 INFO - Downloading/unpacking psutil>=0.7.1 05:21:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:25 INFO - Installing collected packages: psutil 05:21:25 INFO - Running setup.py install for psutil 05:21:25 INFO - building 'psutil._psutil_linux' extension 05:21:25 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:26 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:26 INFO - building 'psutil._psutil_posix' extension 05:21:26 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:26 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:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:26 INFO - Successfully installed psutil 05:21:26 INFO - Cleaning up... 05:21:26 INFO - Return code: 0 05:21:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:21:26 INFO - Using env: {'DISPLAY': ':0', 05:21:26 INFO - 'HOME': '/home/cltbld', 05:21:26 INFO - 'LANG': 'en_US.UTF-8', 05:21:26 INFO - 'LANGUAGE': 'en_US:en', 05:21:26 INFO - 'LOGNAME': 'cltbld', 05:21:26 INFO - 'MAIL': '/var/mail/cltbld', 05:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:26 INFO - 'MOZ_NO_REMOTE': '1', 05:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:26 INFO - 'NO_EM_RESTART': '1', 05:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:26 INFO - 'PWD': '/builds/slave/test', 05:21:26 INFO - 'SHELL': '/bin/bash', 05:21:26 INFO - 'SHLVL': '1', 05:21:26 INFO - 'TERM': 'linux', 05:21:26 INFO - 'TMOUT': '86400', 05:21:26 INFO - 'USER': 'cltbld', 05:21:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:26 INFO - '_': '/tools/buildbot/bin/python'} 05:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:28 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:28 INFO - Installing collected packages: mozsystemmonitor 05:21:28 INFO - Running setup.py install for mozsystemmonitor 05:21:28 INFO - Successfully installed mozsystemmonitor 05:21:28 INFO - Cleaning up... 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 05:21:28 INFO - 'HOME': '/home/cltbld', 05:21:28 INFO - 'LANG': 'en_US.UTF-8', 05:21:28 INFO - 'LANGUAGE': 'en_US:en', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MAIL': '/var/mail/cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SHLVL': '1', 05:21:28 INFO - 'TERM': 'linux', 05:21:28 INFO - 'TMOUT': '86400', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - '_': '/tools/buildbot/bin/python'} 05:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - Downloading docopt-0.6.1.tar.gz 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:31 INFO - Running setup.py install for blobuploader 05:21:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:31 INFO - Running setup.py install for requests 05:21:32 INFO - Running setup.py install for docopt 05:21:32 INFO - Successfully installed blobuploader requests docopt 05:21:32 INFO - Cleaning up... 05:21:32 INFO - Return code: 0 05:21:32 INFO - Installing None 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', '--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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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', '--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:32 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: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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:32 INFO - Running setup.py (path:/tmp/pip-uF3B9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:32 INFO - Running setup.py (path:/tmp/pip-N1ZPgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:32 INFO - Running setup.py (path:/tmp/pip-X3WTiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:32 INFO - Running setup.py (path:/tmp/pip-QLsBDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:32 INFO - Running setup.py (path:/tmp/pip-mqSh_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:32 INFO - Running setup.py (path:/tmp/pip-8gEzFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:32 INFO - Running setup.py (path:/tmp/pip-3cim35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:33 INFO - Running setup.py (path:/tmp/pip-BjTApN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:33 INFO - Running setup.py (path:/tmp/pip-teIKKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:33 INFO - Running setup.py (path:/tmp/pip-YdGV9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:33 INFO - Running setup.py (path:/tmp/pip-AXCzgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:33 INFO - Running setup.py (path:/tmp/pip-rD3SNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:33 INFO - Running setup.py (path:/tmp/pip-bHEY4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:33 INFO - Running setup.py (path:/tmp/pip-3YCBYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:33 INFO - Running setup.py (path:/tmp/pip-eRbtpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:33 INFO - Running setup.py (path:/tmp/pip-VHVJCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:33 INFO - Running setup.py (path:/tmp/pip-6jl3w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:33 INFO - Running setup.py install for manifestparser 05:21:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:33 INFO - Running setup.py install for mozcrash 05:21:34 INFO - Running setup.py install for mozdebug 05:21:34 INFO - Running setup.py install for mozdevice 05:21:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for mozfile 05:21:34 INFO - Running setup.py install for mozhttpd 05:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for mozinfo 05:21:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for mozInstall 05:21:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for mozleak 05:21:34 INFO - Running setup.py install for mozlog 05:21:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for moznetwork 05:21:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:34 INFO - Running setup.py install for mozprocess 05:21:35 INFO - Running setup.py install for mozprofile 05:21:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Running setup.py install for mozrunner 05:21:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Running setup.py install for mozscreenshot 05:21:35 INFO - Running setup.py install for moztest 05:21:35 INFO - Running setup.py install for mozversion 05:21:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:35 INFO - Cleaning up... 05:21:35 INFO - Return code: 0 05:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:35 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 05:21:35 INFO - 'HOME': '/home/cltbld', 05:21:35 INFO - 'LANG': 'en_US.UTF-8', 05:21:35 INFO - 'LANGUAGE': 'en_US:en', 05:21:35 INFO - 'LOGNAME': 'cltbld', 05:21:35 INFO - 'MAIL': '/var/mail/cltbld', 05:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:35 INFO - 'MOZ_NO_REMOTE': '1', 05:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:35 INFO - 'NO_EM_RESTART': '1', 05:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:35 INFO - 'PWD': '/builds/slave/test', 05:21:35 INFO - 'SHELL': '/bin/bash', 05:21:35 INFO - 'SHLVL': '1', 05:21:35 INFO - 'TERM': 'linux', 05:21:35 INFO - 'TMOUT': '86400', 05:21:35 INFO - 'USER': 'cltbld', 05:21:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:35 INFO - '_': '/tools/buildbot/bin/python'} 05:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:35 INFO - Running setup.py (path:/tmp/pip-m0Wncz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:35 INFO - Running setup.py (path:/tmp/pip-nV7q9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:35 INFO - Running setup.py (path:/tmp/pip-YMioW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:36 INFO - Running setup.py (path:/tmp/pip-dcX4JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:36 INFO - Running setup.py (path:/tmp/pip-1pnyc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:36 INFO - Running setup.py (path:/tmp/pip-Xg8WHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:36 INFO - Running setup.py (path:/tmp/pip-2OdGws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:36 INFO - Running setup.py (path:/tmp/pip-TuFskg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:36 INFO - Running setup.py (path:/tmp/pip-BAFPsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:36 INFO - Running setup.py (path:/tmp/pip-KC1X26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:36 INFO - Running setup.py (path:/tmp/pip-Mtwr01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:36 INFO - Running setup.py (path:/tmp/pip-mIbZ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:36 INFO - Running setup.py (path:/tmp/pip-78J4s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:36 INFO - Running setup.py (path:/tmp/pip-8b1CTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:36 INFO - Running setup.py (path:/tmp/pip-MhB9il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:36 INFO - Running setup.py (path:/tmp/pip-fKxc1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:36 INFO - Running setup.py (path:/tmp/pip-2GPlQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:37 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:37 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:37 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:37 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:37 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:37 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:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:38 INFO - Downloading blessings-1.6.tar.gz 05:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:38 INFO - Installing collected packages: blessings 05:21:38 INFO - Running setup.py install for blessings 05:21:39 INFO - Successfully installed blessings 05:21:39 INFO - Cleaning up... 05:21:39 INFO - Return code: 0 05:21:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:39 INFO - Reading from file tmpfile_stdout 05:21:39 INFO - Current package versions: 05:21:39 INFO - argparse == 1.2.1 05:21:39 INFO - blessings == 1.6 05:21:39 INFO - blobuploader == 1.2.4 05:21:39 INFO - docopt == 0.6.1 05:21:39 INFO - manifestparser == 1.1 05:21:39 INFO - mozInstall == 1.12 05:21:39 INFO - mozcrash == 0.17 05:21:39 INFO - mozdebug == 0.1 05:21:39 INFO - mozdevice == 0.48 05:21:39 INFO - mozfile == 1.2 05:21:39 INFO - mozhttpd == 0.7 05:21:39 INFO - mozinfo == 0.9 05:21:39 INFO - mozleak == 0.1 05:21:39 INFO - mozlog == 3.1 05:21:39 INFO - moznetwork == 0.27 05:21:39 INFO - mozprocess == 0.22 05:21:39 INFO - mozprofile == 0.28 05:21:39 INFO - mozrunner == 6.11 05:21:39 INFO - mozscreenshot == 0.1 05:21:39 INFO - mozsystemmonitor == 0.0 05:21:39 INFO - moztest == 0.7 05:21:39 INFO - mozversion == 1.4 05:21:39 INFO - psutil == 3.1.1 05:21:39 INFO - requests == 1.2.3 05:21:39 INFO - wsgiref == 0.1.2 05:21:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:39 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 05:21:39 INFO - 'HOME': '/home/cltbld', 05:21:39 INFO - 'LANG': 'en_US.UTF-8', 05:21:39 INFO - 'LANGUAGE': 'en_US:en', 05:21:39 INFO - 'LOGNAME': 'cltbld', 05:21:39 INFO - 'MAIL': '/var/mail/cltbld', 05:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:39 INFO - 'MOZ_NO_REMOTE': '1', 05:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:39 INFO - 'NO_EM_RESTART': '1', 05:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:39 INFO - 'PWD': '/builds/slave/test', 05:21:39 INFO - 'SHELL': '/bin/bash', 05:21:39 INFO - 'SHLVL': '1', 05:21:39 INFO - 'TERM': 'linux', 05:21:39 INFO - 'TMOUT': '86400', 05:21:39 INFO - 'USER': 'cltbld', 05:21:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:39 INFO - '_': '/tools/buildbot/bin/python'} 05:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Cleaning up... 05:21:39 INFO - Return code: 0 05:21:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:39 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 05:21:39 INFO - 'HOME': '/home/cltbld', 05:21:39 INFO - 'LANG': 'en_US.UTF-8', 05:21:39 INFO - 'LANGUAGE': 'en_US:en', 05:21:39 INFO - 'LOGNAME': 'cltbld', 05:21:39 INFO - 'MAIL': '/var/mail/cltbld', 05:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:39 INFO - 'MOZ_NO_REMOTE': '1', 05:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:39 INFO - 'NO_EM_RESTART': '1', 05:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:39 INFO - 'PWD': '/builds/slave/test', 05:21:39 INFO - 'SHELL': '/bin/bash', 05:21:39 INFO - 'SHLVL': '1', 05:21:39 INFO - 'TERM': 'linux', 05:21:39 INFO - 'TMOUT': '86400', 05:21:39 INFO - 'USER': 'cltbld', 05:21:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:39 INFO - '_': '/tools/buildbot/bin/python'} 05:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:39 INFO - Downloading/unpacking jsonschema 05:21:39 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:39 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:39 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:39 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:39 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:39 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:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:41 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:41 INFO - warning: no files found matching '*.txt' 05:21:41 INFO - no previously-included directories found matching 'build' 05:21:41 INFO - no previously-included directories found matching 'dist' 05:21:41 INFO - no previously-included directories found matching '.git*' 05:21:41 INFO - Installing collected packages: jsonschema, functools32 05:21:42 INFO - Running setup.py install for functools32 05:21:42 INFO - warning: no files found matching '*.txt' 05:21:42 INFO - no previously-included directories found matching 'build' 05:21:42 INFO - no previously-included directories found matching 'dist' 05:21:42 INFO - no previously-included directories found matching '.git*' 05:21:42 INFO - Successfully installed jsonschema functools32 05:21:42 INFO - Cleaning up... 05:21:42 INFO - Return code: 0 05:21:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:42 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 0x7fb0ba269f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 05:21:42 INFO - 'HOME': '/home/cltbld', 05:21:42 INFO - 'LANG': 'en_US.UTF-8', 05:21:42 INFO - 'LANGUAGE': 'en_US:en', 05:21:42 INFO - 'LOGNAME': 'cltbld', 05:21:42 INFO - 'MAIL': '/var/mail/cltbld', 05:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:42 INFO - 'MOZ_NO_REMOTE': '1', 05:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:42 INFO - 'NO_EM_RESTART': '1', 05:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:42 INFO - 'PWD': '/builds/slave/test', 05:21:42 INFO - 'SHELL': '/bin/bash', 05:21:42 INFO - 'SHLVL': '1', 05:21:42 INFO - 'TERM': 'linux', 05:21:42 INFO - 'TMOUT': '86400', 05:21:42 INFO - 'USER': 'cltbld', 05:21:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:42 INFO - '_': '/tools/buildbot/bin/python'} 05:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:42 INFO - Downloading/unpacking flake8 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 flake8-2.5.0-py2.py3-none-any.whl 05:21:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:44 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:44 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 - 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:44 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:44 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:44 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 mccabe-0.3.1-py2.py3-none-any.whl 05:21:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:44 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:44 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 - 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:44 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:44 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:44 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/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:44 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:44 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 - 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:44 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:44 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:44 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 - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:44 INFO - no previously-included directories found matching 'docs/_build' 05:21:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:45 INFO - Running setup.py install for pep8 05:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:45 INFO - no previously-included directories found matching 'docs/_build' 05:21:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:45 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Running post-action listener: _resource_record_post_action 05:21:45 INFO - Running post-action listener: _start_resource_monitoring 05:21:45 INFO - Starting resource monitoring. 05:21:45 INFO - ##### 05:21:45 INFO - ##### Running install step. 05:21:45 INFO - ##### 05:21:45 INFO - Running pre-action listener: _resource_record_pre_action 05:21:45 INFO - Running main action method: install 05:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:45 INFO - Reading from file tmpfile_stdout 05:21:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:45 INFO - Reading from file tmpfile_stdout 05:21:45 INFO - Output received: 05:21:45 INFO - Usage: mozinstall [options] installer 05:21:45 INFO - Options: 05:21:45 INFO - -h, --help show this help message and exit 05:21:45 INFO - -d DEST, --destination=DEST 05:21:45 INFO - Directory to install application into. [default: 05:21:45 INFO - "/builds/slave/test"] 05:21:45 INFO - --app=APP Application being installed. [default: firefox] 05:21:45 INFO - mkdir: /builds/slave/test/build/application 05:21:45 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:45 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:01 INFO - Reading from file tmpfile_stdout 05:22:01 INFO - Output received: 05:22:01 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:01 INFO - Running post-action listener: _resource_record_post_action 05:22:01 INFO - ##### 05:22:01 INFO - ##### Running run-tests step. 05:22:01 INFO - ##### 05:22:01 INFO - Running pre-action listener: _resource_record_pre_action 05:22:01 INFO - Running main action method: run_tests 05:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:01 INFO - Python 2.7.3 05:22:01 INFO - Return code: 0 05:22:01 INFO - grabbing minidump binary from tooltool 05:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:01 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 0x2376410>, '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 0x2377310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23777a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:01 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:01 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:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:01 INFO - Return code: 0 05:22:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:02 INFO - Return code: 0 05:22:02 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-023', '--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:02 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-023 --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:02 INFO - Using env: {'DISPLAY': ':0', 05:22:02 INFO - 'HOME': '/home/cltbld', 05:22:02 INFO - 'LANG': 'en_US.UTF-8', 05:22:02 INFO - 'LANGUAGE': 'en_US:en', 05:22:02 INFO - 'LOGNAME': 'cltbld', 05:22:02 INFO - 'MAIL': '/var/mail/cltbld', 05:22:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:02 INFO - 'MOZ_NO_REMOTE': '1', 05:22:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:02 INFO - 'NO_EM_RESTART': '1', 05:22:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:02 INFO - 'PWD': '/builds/slave/test', 05:22:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:02 INFO - 'SHELL': '/bin/bash', 05:22:02 INFO - 'SHLVL': '1', 05:22:02 INFO - 'TERM': 'linux', 05:22:02 INFO - 'TMOUT': '86400', 05:22:02 INFO - 'USER': 'cltbld', 05:22:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681', 05:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:02 INFO - '_': '/tools/buildbot/bin/python'} 05:22:02 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-023', '--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:02 INFO - mozversion application_buildid: 20160422035423 05:22:02 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:22:02 INFO - mozversion application_display_name: Nightly 05:22:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:02 INFO - mozversion application_name: Firefox 05:22:02 INFO - mozversion application_remotingname: firefox 05:22:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:02 INFO - mozversion application_vendor: Mozilla 05:22:02 INFO - mozversion application_version: 48.0a1 05:22:02 INFO - mozversion platform_buildid: 20160422035423 05:22:02 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:22:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:02 INFO - mozversion platform_version: 48.0a1 05:22:02 INFO - using testdate: 1461586922 05:22:02 INFO - actual date: 1461586922 05:22:02 INFO - starting webserver on 'localhost:49784' 05:22:02 INFO - SUITE-START | Running 2 tests 05:22:02 INFO - TEST-START | dromaeo_css 05:22:02 INFO - operating with platform_type : linux_ 05:22:02 INFO - Initialising browser for dromaeo_css test... 05:22:02 INFO - TEST-INFO | started process 20988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzv7Vog/profile http://localhost:49784/getInfo.html) 05:22:06 INFO - PROCESS | 20988 | __metrics Screen width/height:1600/1200 05:22:06 INFO - PROCESS | 20988 | colorDepth:24 05:22:06 INFO - PROCESS | 20988 | Browser inner width/height: 1024/697 05:22:06 INFO - PROCESS | 20988 | __metrics 05:22:07 ERROR - PROCESS | 20988 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:22:08 INFO - TEST-INFO | 20988: exit 0 05:22:08 INFO - Browser initialized. 05:22:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:08 INFO - TEST-INFO | started process 21067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzv7Vog/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:20 INFO - PROCESS | 21067 | RSS: Main: 155795456 05:22:20 INFO - PROCESS | 21067 | 05:23:12 INFO - PROCESS | 21067 | 1461586992086 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:22 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49784/tests/dromaeo/cssquery-ext.html) 05:25:24 INFO - PROCESS | 21067 | RSS: Main: 331452416 05:25:24 INFO - PROCESS | 21067 | 05:28:27 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-ext.html (next: http://localhost:49784/tests/dromaeo/cssquery-jquery.html) 05:28:27 INFO - PROCESS | 21067 | RSS: Main: 233054208 05:28:27 INFO - PROCESS | 21067 | 05:31:30 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49784/tests/dromaeo/cssquery-mootools.html) 05:31:30 INFO - PROCESS | 21067 | RSS: Main: 237314048 05:31:30 INFO - PROCESS | 21067 | 05:34:32 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49784/tests/dromaeo/cssquery-prototype.html) 05:34:33 INFO - PROCESS | 21067 | RSS: Main: 234975232 05:34:33 INFO - PROCESS | 21067 | 05:37:36 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49784/tests/dromaeo/cssquery-yui.html) 05:37:36 INFO - PROCESS | 21067 | RSS: Main: 224083968 05:37:36 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | Cycle 1(1): loaded http://localhost:49784/tests/dromaeo/cssquery-yui.html (next: http://localhost:49784/tests/dromaeo/cssquery-dojo.html) 05:40:39 INFO - PROCESS | 21067 | RSS: Main: 262131712 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | __start_tp_report 05:40:39 INFO - PROCESS | 21067 | _x_x_mozilla_page_load 05:40:39 INFO - PROCESS | 21067 | _x_x_mozilla_page_load_details 05:40:39 INFO - PROCESS | 21067 | |i|pagename|runs| 05:40:39 INFO - PROCESS | 21067 | |0;dojo.html;2602.4664943686544;2662.29449195963;2667.359833639927;2691.8923243070276;2699.9595006074906;4569.977150114245;4632.235681112621;4642.5821676049145;4658.813647454102;4668.346431499588;4631.837885674002;4733.360996265503;4790.089882922242;4798.568128868401;4815.0610630926985;4328.935065974005;4330.523642399334;4388.956110438887;4431.180231657154;4455.398521199629;4338.457692788402;4378.211921854065;4434.401355816955;4461.754603496806;4481.6862819602475;4244.257254980397;4344.9348259776125;4401.229784787682;4404.955950440487;4410.536893626171;4252.2345977724;4275.016746148403;4286.292761694317;4320.503142138631;4321.37340085689;4296.162248361571;4320.65434765218;4326.891827704301;4365.912681746379;4383.167198232326;4528.207563676344;4610.423697037871;4615.538446155391;4624.8150073997;4630.467496237942;5020.748962551857;5050.242463630485;5052.242163675442;5054.11552978231;5104.897902041938;5057.69653820772;5057.822976195852;5057.974710126426;5067.467915868818;5127.9743601282125;4554.863354099382;4626.791794369262;4723.338732577442;4736.123817093849;4736.786844592001;5172.379314482287;5197.428282888879;5203.791848326025;5209.114450543417;5251.737413129328;4963.70217786934;4979.775910084055;4989.25161225819;4990.525900039563;5032.899342013139;4919.483454237254;4954.455009948902;5035;5048.242763585418;5056.342675452168;4947;4972.0801651694555;4977.352944117241;4984.127777638899;5018.949810501921;4989.052080104769;4989.800407983713;4990.850274491771;4993.825216117419;5027.497250275016;4162.438070860456;4205.453291072141;4256.34026725858;4264.061906380592;4268.722533035405;3682.4844521766972;3693.9261214776093;3698.7041036716996;3729.5151630288433;3738.0841693785196;4305.9569404306185;4307.5261721210645;4317.892052698645;4351.69538132334;4355.7822108894425;4943.060818444484;5001.44984051754;5032.899342013213;5088.135017047037;5096.566791822663;4207;4232.724872883315;4232.746035237896;4234.661227101825;4279.40088387626;4429.435403652537;4432.889177770517;4439.223135951195;4471.709338892962;4475.1049790042125;4620.630349572026;4760.119377915166;4832.903341933072;4839.346688197189;4857.028594281087;4895.412550493964;4919.704817710805;4920.630952678635;4923.236898280772;4958.157113290677;4604.8388306409115;4611.239145540948;4620.653450991122;4640.512746161605;4668.463126740333;4800.927986080142;4845.685030473008;4894.461609222912;4895.143349913679;4898.069366820293;4945.307656927961;4989.501049895127;4990.4011518618;4992.425871024879;4992.650514463952;4843.564079232886;4858.732769697701;4858.854234372974;4863.440704318907;4865.513448655106;4838.056578967208;4844.563989240985;4865.829695960766;4872.488388719134;4954.900901982012;4858.805647774191;4859.222524396079;4877.756112194447;4891.29076283944;4928.408590969107;4906.828261010847;4964.751762411937;4985.950140498694;4986.700797952134;5015.924761128513;4676.672632915664;4758.024604955906;4761.214399624023;4767.09425209223;4852.830150944841 05:40:39 INFO - PROCESS | 21067 | |1;ext.html;550.7282459853107;587.9882402351953;605.0561124645551;610.7740136149625;618.2858798088209;32822.507662385055;34053.829730851314;34054.82972585137;34160.829195853985;34171.65828341716;36965.26069478609;37806.43290350647;37818.81090594543;37904.81047594758;37946.430803537965;7365.963170184142;7615.238476152396;7621.542707437571;7629.694812207533;7857.6856925722905;7529.661165247549;9800.803983920317;10197.796044079114;10198.949005254963;10207.540660670287;9867.210623150168;9965.252606054539;9971.75070623233;9978.30151889368;9981.800363992716;7411.518251313647;9784.217262618973;9789.118979291863;9843.753906152404;9915.80168396628;9720.368176068532;9836.557354918974;9874.061964113398;9875.654352097643;9875.901240987641;33980;34327.313453730785;34337.14157146066;34356.82821585901;34366.14084647879;2715.3618899558587;2746.426817349729;3228.0124482150422;3237.14215732831;3241.8216998065095;28540.714592854012;28541;28877.42245155085;29053;29563.556546651816;3410.7380269300515;3425.6060553036223;3516.279162771651;3531.3820081485637;3553.218291975761;214469;216875;217514;217646;217692;32337.838310808296;50563.241551376756;51164.74417627962;51377;51430.74284628553;31658.208544786103;31710.2072448186;31786.841065794986;31791;31817.52273715896;12068.698282542831;12380.257184568954;12387.566435174725;12397.194182378296;12408.317542535067;9447.763805904908;9627.90372096284;9885.308028437941;10111.898881011242;10500.894991050145;7917;7942.245486678757;7991.400644951652;8070.596470176468;8076.636551355203;3135.7804953653026;3180.666030066856;3198.233527998265;3212.2772376215166;3227.4674678678225;881.1320848963766;903.3450748207497;957.4590356448723;990.8860481044628;1000.4647513580345;27074.864625676746;27738.861305693343;27755.722442775717;28233.858830706125;28398.574021389282;969.9854502182473;982.6511588386163;1000.2748007694363;1002.5989604158395;1055.6516349604765;14344.313238036048;14594.562163135122;14928.850711492963;14973.475928342456;15018.249087545579;361359;368469;369563;370029;370467;47310;48081.75959120252;48127.278090828666;48144;48152.5184748155;1065.808154532176;1155.4627098399285;1161.5876363890698;1229.5327775445273;1257.905657075723;25842.35394115162;27764.60960384047;28014;28302.292442689097;28344.71655283421;38543.614563854004;38906.61093389143;39202.80398597989;39204;39262;234776;235270;235679;235699;236329;21915;24211.273661790176;25255.494890101727;25417.364565886;25548.361290967874;35527.644723553465;35706.10734731652;36366;36505;37019.44470832886;33070.66929330676;33580.328393432486;34483.82758086194;34801;34941.126471838405;33728.66271337353;33977.49033764446;34109.317813644084;34248.82875585606;34327.65672343245;34003.48994765031;34645.13387165341;34884.82557587297;34967.65032349644;35110.12224694403;30026.69973300239;30484;30694.539581906734;30708.385832283675;30976.380472390876;23807;23852.64221036651;23921.760782391953;24165;24204.273871783873 05:40:39 INFO - PROCESS | 21067 | |2;jquery.html;376.78146674928536;379.66779068315225;379.70003697079306;381.1766584178176;388.115097577523;10392.896071039288;11021.338719676805;11025.062869656089;11027.614033508838;15811.762823557641;16340;16661.083640399775;16997.405090821823;17021.40425085122;17041.57396065099;4978.925316120243;5664.603477756558;5802.796902108427;5810.56420768442;5813;5637.154426835967;5814.738336774834;5815.302163740357;5817.767289308444;5819.534437245032;6559.409653131217;6882.380585747282;6929.514933954625;6936.79189624312;6937.306269373073;6834.624095674736;6903.965480172592;6971.268016858207;6972.1981972072845;6975.895361569581;6803.843346631084;6919;6924.480663950174;6936.132983377078;6979.511434199608;22370.44073898149;22653.886730566406;22811.543769124524;23187.420314492105;23199.88400057989;2003.9799602003939;2007.8895660738654;2013.5268211970176;2047.4164863013968;2075.294399904025;14247.928760356132;14362.138271703627;14368.856311436857;14476.927615361961;14905.254737263094;1831.5512699388735;1897.4118023412786;1956.2761778142037;1987.652160871856;1992.7907569705262;82404.58797706034;83251;86225;86228.11973461146;86279;15786.21068946571;16221.756673649905;16314.18429078565;16395.836041639668;16418.097004664618;29760.55359169614;29903.700962990526;30167.698323016488;30176.54735178974;30178.69821301803;8106.554139522383;8457.112003239694;8529.658813647384;8654.826903461895;8668;6942.687579058955;6983.825404364931;7071.858562828817;7082;7089.680964356617;8109.7161599343735;8203.630836612367;8281.668733250603;8337.874931876027;8385.371097167737;2988.581598576201;3201.935961280808;3267.5588795512776;3353.245519758035;3420.7605467617027;723.5297056912943;777.7200207925142;876.237673224299;912.3112050401904;944.1596978688972;16027.919860400623;16855.157242137844;16912.492625221264;16988.66022679564;17241.741373879402;873.6461732998146;876.9386142970059;891.2513488669549;901.9458832469942;905.4657751926395;7990.840183196304;9330.253579713606;9392.389494682824;9496.477693726772;9631.662891798753;385618;395564;398268;401068;402900;55193;71590.64204678943;76090.61954690191;78749.21250787418;79937.60031199807;912.5619702542684;937.2970272295778;957.2294303086082;985.5466485416645;987.3582171588381;14581.661791162263;15351.309191086651;15568.844311556739;15712.214389280261;15715.921420392824;34040.31919361649;34463.310733785685;34513.48229776606;35564.822175888956;36049.81975090108;50592.241116382545;50860;51559.48440515697;51618.741906290226;52202.73898630482;7513.098428188652;7786.221377862168;7813.335866451415;7863.960680196562;7881.093674227537;10171.491425428847;11311.717207069889;11688.357140357362;11705.122115841175;12019.699507512032;10226.6420675276;10240.743981400525;10259.7435064121;10272.435016073889;10554.419506927192;9642.951785241028;9863.408195508293;10168.69493915154;10253.538590763583;10656;10243;10529.842052369373;10592.470376481298;10797;10973.670789876316;7788.688452461838;7909.485883417559;7952.729161671797;8108.391870609846;8121;9510.191633710936;9715.319927605;9939.105480506789;10054.447005414773;10145.746356340855 05:40:39 INFO - PROCESS | 21067 | |3;mootools.html;1244.6079484962231;1451.5572750311155;1461.1671347332021;1596.6088308364453;1773.3970450046988;6554.672266386679;7675.577843218621;7873.881891771628;7891.487053341529;7904.5652489113145;7724.073111226647;7726.806829829257;7782.4163187761005;7792.610369481532;7811.101723301807;1947.045947485736;2234.4190510467315;2258.4303908783404;2290.919817806377;2292.3695983604557;2286.942826429344;2308.8499247548857;2312.4681323295654;2312.6993490846166;2320.0835669910375;2168.826493880486;2170.305502239284;2216.7783221677782;2217.1907253852387;2218.5895609312247;1898.1173754204292;2156.762756096828;2171.3160354488446;2236.586231547169;2239.4065572623267;2205.911763529457;2231.34175418252;2237.876916769577;2241.025154057974;2241.8430709850318;7713.65288562016;7744.961275193645;7770.961145194295;7771.572563509005;7775.261350171724;4580.473245576768;4708.529147085298;4710.411198600175;4712.858614241578;4736.810527578893;2805.6072149899032;2810.6486689163853;2936.8237905725723;2940.2208414770103;2965.4069186162637;917.6833992272722;922.7047344849651;935.4387367579398;938.4932136646203;949.5774380400725;10823;10825.945870270676;10850.565977360975;10852.782944341068;10856.72858178536;4272.743635381887;4302.397664326997;4451.154280686659;4466.865994020184;4544.386507821468;9252.444853308823;9266.860997085048;9268.860967085498;9292.442453452815;9293.581788819383;4835.685680430761;4837.129316722953;4858.246971719389;4858.7570621468785;4861.173600487926;3787.6212378762452;4300;4409.074094440203;4416.9779151104685;4440.777961101932;3746.494223279822;3775.811209439572;3873.5545412277384;3909.941350879682;3910.6089391061237;1235.7096082420624;1254.4417734108417;1256.3655354046148;1260.3698150924538;1272.7454509098031;654.8952167653152;668.301624802083;677.8745932002595;769.4267770511005;775.693601027591;5075.543201111917;5139.640225184276;5158;5191.22131680251;5203.037438073893;418.98324067036975;432.59336223949384;435.13842591668674;441.99116017679466;443.691634314155;3483.425234836224;3489.8778542750883;3489.8953031409096;3590.5691317042124;3598.3522965865873;9670.661526846667;10090.545925433225;10152.23858210637;10180.134688551409;10202.438865862301;10052.64815731446;10058.245631577662;10058.99410059003;10065.547050382751;10069.597216111273;6996.475264355194;7469.626518674045;7517.924820751722;7564.810879728051;7591.4685971982535;5198.090334191425;5291.60312976536;5323.680579165262;5370.113931201308;5388.326459192601;9184.54077296119;9291.349605527548;9310.394824336396;9316.813663726824;9513.904860951301;8847.46915185091;9394.67118650844;9531.38046027006;9549.570269337757;9688.5640146195;6126.724297406717;6151.292601350902;6826.556273842184;6841.247462778991;6946.305369463013;7500.662470188746;7504.099508059068;7504.311529905727;7553.962230188814;7576.810579735551;6649.501287403367;6826.692798823966;6852.6916288768125;6923.203831559234;6958.269381714847;6797;6815.795526134224;6869.072675188786;6954.79135625932;6974.197967233833;6000.819975400745;6053.424924632153;6070.54470914692;6139.877202456015;6347.587406818542;4520.389747384193;4550.954490455186;4589.701669391479;4593.632509399174;4629.4907560167685;4502;4565.452145742533;4615.399998000238;4625.098105869323;4666.650001249852 05:40:39 INFO - PROCESS | 21067 | |4;prototype.html;308.57416764864485;318.8373929296059;318.9952150717739;322.08527781101697;322.19451371571074;4994.775235114419;5194.402643695967;5213.973930130349;5293;5296.073187192241;4987.276844857493;5189.636725429222;5197.064528384889;5202.8179013734525;5213.540208741549;4048.554658987516;4051.4530538377235;4060.675145988314;4065.1463192729416;4087.4890638670167;3781.924361512768;3814.82833272502;4064.268431682296;4074.22589707956;4081.4898137732785;4011.8997025074314;4026.8187931543152;4040.373742069984;4041.7777022263763;4043.1495795464125;4018.557958624549;4024.4969378827645;4027.335489644205;4030.3349947258666;4032.0927791247027;3462.065242384542;3551.076720052779;3552.3250582389524;3556.822158892071;3560.3235385276716;4942.021672553593;4955.479674634147;4962.4045114586115;4963.305137280783;4978.352814134176;4618;4621.768911554443;4623.676342656016;4633.698809577367;4645.303204519315;5259.921101183485;5452.591055670801;5454.318210223722;5454.509094181542;5460.890782184374;3829.329867273216;3833.884983450501;3837.347650899354;3845.480860083881;3846.7307288489815;5692.686902220376;5756.19413282145;5773.278340207474;5775.797847075332;5788.5369170466265;3809.6571308581806;3929.76421414716;3935;3941.5664276929515;3952.1107750756423;3955.248502784462;3983.382575700771;3989.900252493711;3993.0815912339745;3998.7000974926996;4564.634829213722;4582.312653101994;4592.609628181642;4595.816167353269;4607.838725644653;5421.186821976735;5441.156620723794;5479.75341109651;5500.937148569286;5511.559075273968;1362.8773410392914;1370.4244217428504;1376.800363947242;1383.5503461375092;1384.4047059764196;913.5980168725739;917.458669435355;933.5285680731188;934.6588495199339;936.4802534593366;4799.856004319806;4809.110314591811;4809.879753006203;4811.542903424169;4818.445878723922;5678.744456499468;5679.659220446786;5683.658980461186;5685.204071430003;5701.116326969326;4629.51390104041;4751.2657879873595;4788.808447662054;4792.329073929653;4809.759512024455;3021.3353062326255;3030.6211723534557;3035.590195323647;3043.710847469487;3046.4211799757977;5295.841124766263;5305.151175811851;5307.548858347083;5310.283111779938;5319.946800532022;5649.350324712628;5758.222639943638;5787.102999035156;5799.39106393831;5811.476967072984;5263.868403289948;5274.815381461631;5278.8944221116135;5289.3652761668845;5296;5489.149181876815;5591.692456914909;5599.776008959596;5635.830925072254;5662.858428539154;5508.724563771715;5512.91730624049;5524.226608274765;5533.170024496197;5544.584156188222;5258.106121959199;5272.130098533699;5281.996420680059;5311.839455523957;5341.172118321666;3553.8578456861437;3690.1697118148204;3744.4008958566496;3804.372278574004;3809.1239015026144;5526.253955716088;5621.662700237999;5638.407967163389;5658.660480371191;5659.858503537444;5456.317960254968;5457.808976685797;5468.878879829545;5472.890542189054;5485.945140548543;5213.165893457029;5450.563954883521;5462.863428414322;5463.972680136574;5542.69515176653;5402.9459705404015;5425.321834770653;5459.972700136474;5465.180222966428;5483.506484416422;5522.625271133451;5532.280803495681;5532.972335138459;5548.167774833807;5550.114919556246;5185.196294574347;5384.865378365572;5405.108157154025;5416.133418652997;5425.104857698436 05:40:39 INFO - PROCESS | 21067 | |5;yui.html;663.151166506871;681.6251061915945;686.680693477533;691.1602403080253;717.4188906985339;11562.710932226699;11918.404079796019;11927.343996080212;11929.1649584529;11963.521459141635;12042.75914481712;12913.870861291385;13825.101368411046;13829.585112446617;13867.514636987707;628.8710814283083;777.9260970207821;782.2138750555683;785.8467598818232;787.0358810457201;635.6948664640975;641.9871602567946;643.2313385504324;752.5559919647407;778.6807408962327;828.718235799828;829.1998221716043;830.1947111302028;830.8462934357133;831.476170012891;824.1470078468816;824.3487644760631;824.5011767880466;824.6000689665508;824.9876251856227;482.27899290560487;590.7400743672813;604.6734763227852;605.8757954619336;607.0136028952951;12734.936325318407;12788.744225115539;12798.872011279955;12832.615021549369;12876.420561074774;11762.294262344287;12119.091068169835;12234.388280585936;12303.569375071918;12450.81323780144;9640.276979226586;9922.751931201705;9973.301868869183;10069.043440873105;10131.949340253252;3272.590926134233;3273.885414010498;3317.4526203176447;3318.3363327334387;3408.233147541808;46545.04367128798;46993.530064699255;47355.289670654965;47446.5255347449;47507.99999999965;9388.389754665925;9463.148316651534;9499;9552.617895284111;9575.808483830284;17032.14839258057;17127.914360428367;17206.1396930153;17235.74146387805;17243.655126897393;6464.547481676332;6504.45292620864;6559.24568674599;6568.080468734285;6647.66761661915;3712.294664013829;3758.4926034985474;3791.279656865187;3799.335116354682;3854.672352849983;2864.527352986734;2923.5468502382164;2924.312786495172;2926.1075372011314;2926.2245504941206;485.16309366343484;489.56917912237714;501.4809671989473;505.36576596371316;523.3275241314968;497.2367416016397;561.1526594841819;575.6488541989384;586.0827804485966;602.6504627316147;7279.854402911912;7341.3392794648735;7496.962515187498;7560.281773231534;7802.414818888606;501.98849318623;548.3310361359136;583.5769067426082;602.6896148483535;624.1199908129606;3728.12389088564;3785.2033862896656;3822.503074600284;3913.5108111486065;3921.7254792164845;51801.48198518042;52272.21591676128;52369.21446178311;52373.905043798586;52390.738046309525;48126.75936620295;48172.27741583879;48583;49403.258951115764;49471;43606.127877442275;44143.33784993228;44324.77837610856;44997.32504012442;45164.54835451669;7165.713371465292;7411.96294018548;7429;7464.440166987389;7533.1336896257635;29461.410771784875;29731.256718582208;30133.69866301309;30706.232344191572;30867.536986944764;36582.26835463329;39417.802910985265;39633.80183099066;39803.60196398115;39806.402903957045;8911.866322005304;9097.272218222393;9161.450312981242;9176.862347064665;9218.677346292847;9975.301728878909;10043.949780251345;10079.042490963348;10109.79780404373;10254.436006019741;9567;9717.85423218638;9807.950960245153;9906.405615663083;9997;10401.271910966463;10599.8940010602;10767.838482422927;10823.350598964087;11331.603393881174;10275.794484110425;10324.587016519255;10389.428581428094;10516.737081573021;10746.570137194425;8637.91362086371;8913.777155571162;9226.630934762534;9260.907390926004;9383.812323753624;8724.43291186071;8940.418872773249;8972.865407019031;9118.908810911806;9276.25789936817 05:40:39 INFO - PROCESS | 21067 | __end_tp_report 05:40:39 INFO - PROCESS | 21067 | __start_cc_report 05:40:39 INFO - PROCESS | 21067 | _x_x_mozilla_cycle_collect,1726 05:40:39 INFO - PROCESS | 21067 | __end_cc_report 05:40:39 INFO - PROCESS | 21067 | __startTimestamp1461588039664__endTimestamp 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | ------- Summary: start ------- 05:40:39 INFO - PROCESS | 21067 | Number of tests: 6 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#0] dojo.html Cycles:165 Average:4635.10 Median:4767.09 stddev:481.28 (10.1%) stddev-sans-first:455.58 05:40:39 INFO - PROCESS | 21067 | Values: 2602.5 2662.3 2667.4 2691.9 2700.0 4570.0 4632.2 4642.6 4658.8 4668.3 4631.8 4733.4 4790.1 4798.6 4815.1 4328.9 4330.5 4389.0 4431.2 4455.4 4338.5 4378.2 4434.4 4461.8 4481.7 4244.3 4344.9 4401.2 4405.0 4410.5 4252.2 4275.0 4286.3 4320.5 4321.4 4296.2 4320.7 4326.9 4365.9 4383.2 4528.2 4610.4 4615.5 4624.8 4630.5 5020.7 5050.2 5052.2 5054.1 5104.9 5057.7 5057.8 5058.0 5067.5 5128.0 4554.9 4626.8 4723.3 4736.1 4736.8 5172.4 5197.4 5203.8 5209.1 5251.7 4963.7 4979.8 4989.3 4990.5 5032.9 4919.5 4954.5 5035.0 5048.2 5056.3 4947.0 4972.1 4977.4 4984.1 5018.9 4989.1 4989.8 4990.9 4993.8 5027.5 4162.4 4205.5 4256.3 4264.1 4268.7 3682.5 3693.9 3698.7 3729.5 3738.1 4306.0 4307.5 4317.9 4351.7 4355.8 4943.1 5001.4 5032.9 5088.1 5096.6 4207.0 4232.7 4232.7 4234.7 4279.4 4429.4 4432.9 4439.2 4471.7 4475.1 4620.6 4760.1 4832.9 4839.3 4857.0 4895.4 4919.7 4920.6 4923.2 4958.2 4604.8 4611.2 4620.7 4640.5 4668.5 4800.9 4845.7 4894.5 4895.1 4898.1 4945.3 4989.5 4990.4 4992.4 4992.7 4843.6 4858.7 4858.9 4863.4 4865.5 4838.1 4844.6 4865.8 4872.5 4954.9 4858.8 4859.2 4877.8 4891.3 4928.4 4906.8 4964.8 4986.0 4986.7 5015.9 4676.7 4758.0 4761.2 4767.1 4852.8 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#1] ext.html Cycles:180 Average:41659.20 Median:34135.07 stddev:74116.82 (217.1%) stddev-sans-first:74260.47 05:40:39 INFO - PROCESS | 21067 | Values: 550.7 588.0 605.1 610.8 618.3 32822.5 34053.8 34054.8 34160.8 34171.7 36965.3 37806.4 37818.8 37904.8 37946.4 7366.0 7615.2 7621.5 7629.7 7857.7 7529.7 9800.8 10197.8 10198.9 10207.5 9867.2 9965.3 9971.8 9978.3 9981.8 7411.5 9784.2 9789.1 9843.8 9915.8 9720.4 9836.6 9874.1 9875.7 9875.9 33980.0 34327.3 34337.1 34356.8 34366.1 2715.4 2746.4 3228.0 3237.1 3241.8 28540.7 28541.0 28877.4 29053.0 29563.6 3410.7 3425.6 3516.3 3531.4 3553.2 214469.0 216875.0 217514.0 217646.0 217692.0 32337.8 50563.2 51164.7 51377.0 51430.7 31658.2 31710.2 31786.8 31791.0 31817.5 12068.7 12380.3 12387.6 12397.2 12408.3 9447.8 9627.9 9885.3 10111.9 10500.9 7917.0 7942.2 7991.4 8070.6 8076.6 3135.8 3180.7 3198.2 3212.3 3227.5 881.1 903.3 957.5 990.9 1000.5 27074.9 27738.9 27755.7 28233.9 28398.6 970.0 982.7 1000.3 1002.6 1055.7 14344.3 14594.6 14928.9 14973.5 15018.2 361359.0 368469.0 369563.0 370029.0 370467.0 47310.0 48081.8 48127.3 48144.0 48152.5 1065.8 1155.5 1161.6 1229.5 1257.9 25842.4 27764.6 28014.0 28302.3 28344.7 38543.6 38906.6 39202.8 39204.0 39262.0 234776.0 235270.0 235679.0 235699.0 236329.0 21915.0 24211.3 25255.5 25417.4 25548.4 35527.6 35706.1 36366.0 36505.0 37019.4 33070.7 33580.3 34483.8 34801.0 34941.1 33728.7 33977.5 34109.3 34248.8 34327.7 34003.5 34645.1 34884.8 34967.7 35110.1 30026.7 30484.0 30694.5 30708.4 30976.4 23807.0 23852.6 23921.8 24165.0 24204.3 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#2] jquery.html Cycles:180 Average:25777.28 Median:27785.58 stddev:65559.67 (235.9%) stddev-sans-first:65715.84 05:40:39 INFO - PROCESS | 21067 | Values: 376.8 379.7 379.7 381.2 388.1 10392.9 11021.3 11025.1 11027.6 15811.8 16340.0 16661.1 16997.4 17021.4 17041.6 4978.9 5664.6 5802.8 5810.6 5813.0 5637.2 5814.7 5815.3 5817.8 5819.5 6559.4 6882.4 6929.5 6936.8 6937.3 6834.6 6904.0 6971.3 6972.2 6975.9 6803.8 6919.0 6924.5 6936.1 6979.5 22370.4 22653.9 22811.5 23187.4 23199.9 2004.0 2007.9 2013.5 2047.4 2075.3 14247.9 14362.1 14368.9 14476.9 14905.3 1831.6 1897.4 1956.3 1987.7 1992.8 82404.6 83251.0 86225.0 86228.1 86279.0 15786.2 16221.8 16314.2 16395.8 16418.1 29760.6 29903.7 30167.7 30176.5 30178.7 8106.6 8457.1 8529.7 8654.8 8668.0 6942.7 6983.8 7071.9 7082.0 7089.7 8109.7 8203.6 8281.7 8337.9 8385.4 2988.6 3201.9 3267.6 3353.2 3420.8 723.5 777.7 876.2 912.3 944.2 16027.9 16855.2 16912.5 16988.7 17241.7 873.6 876.9 891.3 901.9 905.5 7990.8 9330.3 9392.4 9496.5 9631.7 385618.0 395564.0 398268.0 401068.0 402900.0 55193.0 71590.6 76090.6 78749.2 79937.6 912.6 937.3 957.2 985.5 987.4 14581.7 15351.3 15568.8 15712.2 15715.9 34040.3 34463.3 34513.5 35564.8 36049.8 50592.2 50860.0 51559.5 51618.7 52202.7 7513.1 7786.2 7813.3 7864.0 7881.1 10171.5 11311.7 11688.4 11705.1 12019.7 10226.6 10240.7 10259.7 10272.4 10554.4 9643.0 9863.4 10168.7 10253.5 10656.0 10243.0 10529.8 10592.5 10797.0 10973.7 7788.7 7909.5 7952.7 8108.4 8121.0 9510.2 9715.3 9939.1 10054.4 10145.7 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#3] mootools.html Cycles:180 Average:5208.08 Median:4709.47 stddev:2970.88 (63.1%) stddev-sans-first:2964.28 05:40:39 INFO - PROCESS | 21067 | Values: 1244.6 1451.6 1461.2 1596.6 1773.4 6554.7 7675.6 7873.9 7891.5 7904.6 7724.1 7726.8 7782.4 7792.6 7811.1 1947.0 2234.4 2258.4 2290.9 2292.4 2286.9 2308.8 2312.5 2312.7 2320.1 2168.8 2170.3 2216.8 2217.2 2218.6 1898.1 2156.8 2171.3 2236.6 2239.4 2205.9 2231.3 2237.9 2241.0 2241.8 7713.7 7745.0 7771.0 7771.6 7775.3 4580.5 4708.5 4710.4 4712.9 4736.8 2805.6 2810.6 2936.8 2940.2 2965.4 917.7 922.7 935.4 938.5 949.6 10823.0 10825.9 10850.6 10852.8 10856.7 4272.7 4302.4 4451.2 4466.9 4544.4 9252.4 9266.9 9268.9 9292.4 9293.6 4835.7 4837.1 4858.2 4858.8 4861.2 3787.6 4300.0 4409.1 4417.0 4440.8 3746.5 3775.8 3873.6 3909.9 3910.6 1235.7 1254.4 1256.4 1260.4 1272.7 654.9 668.3 677.9 769.4 775.7 5075.5 5139.6 5158.0 5191.2 5203.0 419.0 432.6 435.1 442.0 443.7 3483.4 3489.9 3489.9 3590.6 3598.4 9670.7 10090.5 10152.2 10180.1 10202.4 10052.6 10058.2 10059.0 10065.5 10069.6 6996.5 7469.6 7517.9 7564.8 7591.5 5198.1 5291.6 5323.7 5370.1 5388.3 9184.5 9291.3 9310.4 9316.8 9513.9 8847.5 9394.7 9531.4 9549.6 9688.6 6126.7 6151.3 6826.6 6841.2 6946.3 7500.7 7504.1 7504.3 7554.0 7576.8 6649.5 6826.7 6852.7 6923.2 6958.3 6797.0 6815.8 6869.1 6954.8 6974.2 6000.8 6053.4 6070.5 6139.9 6347.6 4520.4 4551.0 4589.7 4593.6 4629.5 4502.0 4565.5 4615.4 4625.1 4666.7 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#4] prototype.html Cycles:180 Average:4521.95 Median:5199.94 stddev:1330.09 (25.6%) stddev-sans-first:1295.68 05:40:39 INFO - PROCESS | 21067 | Values: 308.6 318.8 319.0 322.1 322.2 4994.8 5194.4 5214.0 5293.0 5296.1 4987.3 5189.6 5197.1 5202.8 5213.5 4048.6 4051.5 4060.7 4065.1 4087.5 3781.9 3814.8 4064.3 4074.2 4081.5 4011.9 4026.8 4040.4 4041.8 4043.1 4018.6 4024.5 4027.3 4030.3 4032.1 3462.1 3551.1 3552.3 3556.8 3560.3 4942.0 4955.5 4962.4 4963.3 4978.4 4618.0 4621.8 4623.7 4633.7 4645.3 5259.9 5452.6 5454.3 5454.5 5460.9 3829.3 3833.9 3837.3 3845.5 3846.7 5692.7 5756.2 5773.3 5775.8 5788.5 3809.7 3929.8 3935.0 3941.6 3952.1 3955.2 3983.4 3989.9 3993.1 3998.7 4564.6 4582.3 4592.6 4595.8 4607.8 5421.2 5441.2 5479.8 5500.9 5511.6 1362.9 1370.4 1376.8 1383.6 1384.4 913.6 917.5 933.5 934.7 936.5 4799.9 4809.1 4809.9 4811.5 4818.4 5678.7 5679.7 5683.7 5685.2 5701.1 4629.5 4751.3 4788.8 4792.3 4809.8 3021.3 3030.6 3035.6 3043.7 3046.4 5295.8 5305.2 5307.5 5310.3 5319.9 5649.4 5758.2 5787.1 5799.4 5811.5 5263.9 5274.8 5278.9 5289.4 5296.0 5489.1 5591.7 5599.8 5635.8 5662.9 5508.7 5512.9 5524.2 5533.2 5544.6 5258.1 5272.1 5282.0 5311.8 5341.2 3553.9 3690.2 3744.4 3804.4 3809.1 5526.3 5621.7 5638.4 5658.7 5659.9 5456.3 5457.8 5468.9 5472.9 5485.9 5213.2 5450.6 5462.9 5464.0 5542.7 5402.9 5425.3 5460.0 5465.2 5483.5 5522.6 5532.3 5533.0 5548.2 5550.1 5185.2 5384.9 5405.1 5416.1 5425.1 05:40:39 INFO - PROCESS | 21067 | 05:40:39 INFO - PROCESS | 21067 | [#5] yui.html Cycles:180 Average:12728.17 Median:501.73 stddev:14858.38 (2961.4%) stddev-sans-first:14872.44 05:40:39 INFO - PROCESS | 21067 | Values: 663.2 681.6 686.7 691.2 717.4 11562.7 11918.4 11927.3 11929.2 11963.5 12042.8 12913.9 13825.1 13829.6 13867.5 628.9 777.9 782.2 785.8 787.0 635.7 642.0 643.2 752.6 778.7 828.7 829.2 830.2 830.8 831.5 824.1 824.3 824.5 824.6 825.0 482.3 590.7 604.7 605.9 607.0 12734.9 12788.7 12798.9 12832.6 12876.4 11762.3 12119.1 12234.4 12303.6 12450.8 9640.3 9922.8 9973.3 10069.0 10131.9 3272.6 3273.9 3317.5 3318.3 3408.2 46545.0 46993.5 47355.3 47446.5 47508.0 9388.4 9463.1 9499.0 9552.6 9575.8 17032.1 17127.9 17206.1 17235.7 17243.7 6464.5 6504.5 6559.2 6568.1 6647.7 3712.3 3758.5 3791.3 3799.3 3854.7 2864.5 2923.5 2924.3 2926.1 2926.2 485.2 489.6 501.5 505.4 523.3 497.2 561.2 575.6 586.1 602.7 7279.9 7341.3 7497.0 7560.3 7802.4 502.0 548.3 583.6 602.7 624.1 3728.1 3785.2 3822.5 3913.5 3921.7 51801.5 52272.2 52369.2 52373.9 52390.7 48126.8 48172.3 48583.0 49403.3 49471.0 43606.1 44143.3 44324.8 44997.3 45164.5 7165.7 7412.0 7429.0 7464.4 7533.1 29461.4 29731.3 30133.7 30706.2 30867.5 36582.3 39417.8 39633.8 39803.6 39806.4 8911.9 9097.3 9161.5 9176.9 9218.7 9975.3 10043.9 10079.0 10109.8 10254.4 9567.0 9717.9 9808.0 9906.4 9997.0 10401.3 10599.9 10767.8 10823.4 11331.6 10275.8 10324.6 10389.4 10516.7 10746.6 8637.9 8913.8 9226.6 9260.9 9383.8 8724.4 8940.4 8972.9 9118.9 9276.3 05:40:39 INFO - PROCESS | 21067 | -------- Summary: end -------- 05:40:39 INFO - PROCESS | 21067 | 05:40:40 INFO - TEST-INFO | 21067: exit 0 05:40:40 INFO - TEST-OK | dromaeo_css | took 1117892ms 05:40:40 INFO - TEST-START | kraken 05:40:40 INFO - operating with platform_type : linux_ 05:40:40 INFO - Initialising browser for kraken test... 05:40:40 INFO - TEST-INFO | started process 21244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5s_z_F/profile http://localhost:49784/getInfo.html) 05:40:44 INFO - PROCESS | 21244 | __metrics Screen width/height:1600/1200 05:40:44 INFO - PROCESS | 21244 | colorDepth:24 05:40:44 INFO - PROCESS | 21244 | Browser inner width/height: 1024/697 05:40:44 INFO - PROCESS | 21244 | __metrics 05:40:45 ERROR - PROCESS | 21244 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:40:46 INFO - TEST-INFO | 21244: exit 0 05:40:46 INFO - Browser initialized. 05:40:46 INFO - Running cycle 1/1 for kraken test... 05:40:46 INFO - TEST-INFO | started process 21324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5s_z_F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:58 INFO - PROCESS | 21324 | RSS: Main: 155398144 05:40:58 INFO - PROCESS | 21324 | 05:41:00 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49784/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:01 INFO - PROCESS | 21324 | RSS: Main: 209940480 05:41:01 INFO - PROCESS | 21324 | 05:41:04 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49784/tests/kraken/driver.html?testName=audio-dft) 05:41:05 INFO - PROCESS | 21324 | RSS: Main: 196091904 05:41:05 INFO - PROCESS | 21324 | 05:41:08 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49784/tests/kraken/driver.html?testName=audio-fft) 05:41:09 INFO - PROCESS | 21324 | RSS: Main: 265601024 05:41:09 INFO - PROCESS | 21324 | 05:41:11 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49784/tests/kraken/driver.html?testName=audio-oscillator) 05:41:11 INFO - PROCESS | 21324 | RSS: Main: 174559232 05:41:11 INFO - PROCESS | 21324 | 05:41:14 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:14 INFO - PROCESS | 21324 | RSS: Main: 179650560 05:41:14 INFO - PROCESS | 21324 | 05:41:17 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49784/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:18 INFO - PROCESS | 21324 | RSS: Main: 214634496 05:41:18 INFO - PROCESS | 21324 | 05:41:21 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49784/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:22 INFO - PROCESS | 21324 | RSS: Main: 215638016 05:41:22 INFO - PROCESS | 21324 | 05:41:25 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49784/tests/kraken/driver.html?testName=json-parse-financial) 05:41:26 INFO - PROCESS | 21324 | RSS: Main: 215404544 05:41:26 INFO - PROCESS | 21324 | 05:41:27 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:28 INFO - PROCESS | 21324 | RSS: Main: 201879552 05:41:28 INFO - PROCESS | 21324 | 05:41:30 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:30 INFO - PROCESS | 21324 | RSS: Main: 205275136 05:41:30 INFO - PROCESS | 21324 | 05:41:32 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:33 INFO - PROCESS | 21324 | RSS: Main: 218886144 05:41:33 INFO - PROCESS | 21324 | 05:41:36 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:36 INFO - PROCESS | 21324 | RSS: Main: 224768000 05:41:36 INFO - PROCESS | 21324 | 05:41:39 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:40 INFO - PROCESS | 21324 | RSS: Main: 217481216 05:41:40 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | Cycle 1(1): loaded http://localhost:49784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49784/tests/kraken/driver.html?testName=ai-astar) 05:41:42 INFO - PROCESS | 21324 | RSS: Main: 281640960 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | __start_tp_report 05:41:42 INFO - PROCESS | 21324 | _x_x_mozilla_page_load 05:41:42 INFO - PROCESS | 21324 | _x_x_mozilla_page_load_details 05:41:42 INFO - PROCESS | 21324 | |i|pagename|runs| 05:41:42 INFO - PROCESS | 21324 | |0;ai-astar;111;113;106;111;113;113;100;112;112;112 05:41:42 INFO - PROCESS | 21324 | |1;audio-beat-detection;168;135;160;189;131;155;156;140;209;138 05:41:42 INFO - PROCESS | 21324 | |2;audio-dft;161;161;162;163;162;163;161;160;161;160 05:41:42 INFO - PROCESS | 21324 | |3;audio-fft;73;74;127;117;77;73;74;121;106;74 05:41:42 INFO - PROCESS | 21324 | |4;audio-oscillator;94;93;145;93;94;94;139;94;94;149 05:41:42 INFO - PROCESS | 21324 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;118 05:41:42 INFO - PROCESS | 21324 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 05:41:42 INFO - PROCESS | 21324 | |7;imaging-desaturate;95;95;95;95;94;94;94;95;95;95 05:41:42 INFO - PROCESS | 21324 | |8;json-parse-financial;64;66;63;64;65;64;64;87;61;64 05:41:42 INFO - PROCESS | 21324 | |9;json-stringify-tinderbox;64;65;64;64;65;64;65;64;64;65 05:41:42 INFO - PROCESS | 21324 | |10;stanford-crypto-aes;78;79;77;78;79;79;79;80;81;81 05:41:42 INFO - PROCESS | 21324 | |11;stanford-crypto-ccm;131;132;133;141;130;128;139;131;166;145 05:41:42 INFO - PROCESS | 21324 | |12;stanford-crypto-pbkdf2;177;182;179;178;180;187;181;177;174;175 05:41:42 INFO - PROCESS | 21324 | |13;stanford-crypto-sha256-iterative;75;73;72;74;73;72;73;71;71;76 05:41:42 INFO - PROCESS | 21324 | __end_tp_report 05:41:42 INFO - PROCESS | 21324 | __start_cc_report 05:41:42 INFO - PROCESS | 21324 | _x_x_mozilla_cycle_collect,1878 05:41:42 INFO - PROCESS | 21324 | __end_cc_report 05:41:42 INFO - PROCESS | 21324 | __startTimestamp1461588102584__endTimestamp 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | ------- Summary: start ------- 05:41:42 INFO - PROCESS | 21324 | Number of tests: 14 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.41 05:41:42 INFO - PROCESS | 21324 | Values: 111.0 113.0 106.0 111.0 113.0 113.0 100.0 112.0 112.0 112.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:158.00 stddev:25.08 (15.9%) stddev-sans-first:26.34 05:41:42 INFO - PROCESS | 21324 | Values: 168.0 135.0 160.0 189.0 131.0 155.0 156.0 140.0 209.0 138.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:41:42 INFO - PROCESS | 21324 | Values: 161.0 161.0 162.0 163.0 162.0 163.0 161.0 160.0 161.0 160.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#3] audio-fft Cycles:10 Average:91.60 Median:73.50 stddev:23.10 (31.4%) stddev-sans-first:23.51 05:41:42 INFO - PROCESS | 21324 | Values: 73.0 74.0 127.0 117.0 77.0 73.0 74.0 121.0 106.0 74.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:24.57 (26.1%) stddev-sans-first:25.46 05:41:42 INFO - PROCESS | 21324 | Values: 94.0 93.0 145.0 93.0 94.0 94.0 139.0 94.0 94.0 149.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:41:42 INFO - PROCESS | 21324 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:41:42 INFO - PROCESS | 21324 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:41:42 INFO - PROCESS | 21324 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:64.00 stddev:7.42 (11.6%) stddev-sans-first:7.83 05:41:42 INFO - PROCESS | 21324 | Values: 64.0 66.0 63.0 64.0 65.0 64.0 64.0 87.0 61.0 64.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:41:42 INFO - PROCESS | 21324 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.29 (1.6%) stddev-sans-first:1.30 05:41:42 INFO - PROCESS | 21324 | Values: 78.0 79.0 77.0 78.0 79.0 79.0 79.0 80.0 81.0 81.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:136.00 stddev:11.37 (8.4%) stddev-sans-first:11.81 05:41:42 INFO - PROCESS | 21324 | Values: 131.0 132.0 133.0 141.0 130.0 128.0 139.0 131.0 166.0 145.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:179.50 stddev:3.77 (2.1%) stddev-sans-first:3.93 05:41:42 INFO - PROCESS | 21324 | Values: 177.0 182.0 179.0 178.0 180.0 187.0 181.0 177.0 174.0 175.0 05:41:42 INFO - PROCESS | 21324 | 05:41:42 INFO - PROCESS | 21324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:1.63 (2.2%) stddev-sans-first:1.56 05:41:42 INFO - PROCESS | 21324 | Values: 75.0 73.0 72.0 74.0 73.0 72.0 73.0 71.0 71.0 76.0 05:41:42 INFO - PROCESS | 21324 | -------- Summary: end -------- 05:41:42 INFO - PROCESS | 21324 | 05:41:43 INFO - TEST-INFO | 21324: exit 0 05:41:43 INFO - TEST-OK | kraken | took 63155ms 05:41:43 INFO - SUITE-END | took 1181s 05:41:43 INFO - Completed test suite (00:19:41) 05:41:43 INFO - javascript benchmark 05:41:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.4664943686544, 2662.29449195963, 2667.359833639927, 2691.8923243070276, 2699.9595006074906, 4569.977150114245, 4632.235681112621, 4642.5821676049145, 4658.813647454102, 4668.346431499588, 4631.837885674002, 4733.360996265503, 4790.089882922242, 4798.568128868401, 4815.0610630926985, 4328.935065974005, 4330.523642399334, 4388.956110438887, 4431.180231657154, 4455.398521199629, 4338.457692788402, 4378.211921854065, 4434.401355816955, 4461.754603496806, 4481.6862819602475, 4244.257254980397, 4344.9348259776125, 4401.229784787682, 4404.955950440487, 4410.536893626171, 4252.2345977724, 4275.016746148403, 4286.292761694317, 4320.503142138631, 4321.37340085689, 4296.162248361571, 4320.65434765218, 4326.891827704301, 4365.912681746379, 4383.167198232326, 4528.207563676344, 4610.423697037871, 4615.538446155391, 4624.8150073997, 4630.467496237942, 5020.748962551857, 5050.242463630485, 5052.242163675442, 5054.11552978231, 5104.897902041938, 5057.69653820772, 5057.822976195852, 5057.974710126426, 5067.467915868818, 5127.9743601282125, 4554.863354099382, 4626.791794369262, 4723.338732577442, 4736.123817093849, 4736.786844592001, 5172.379314482287, 5197.428282888879, 5203.791848326025, 5209.114450543417, 5251.737413129328, 4963.70217786934, 4979.775910084055, 4989.25161225819, 4990.525900039563, 5032.899342013139, 4919.483454237254, 4954.455009948902, 5035.0, 5048.242763585418, 5056.342675452168, 4947.0, 4972.0801651694555, 4977.352944117241, 4984.127777638899, 5018.949810501921, 4989.052080104769, 4989.800407983713, 4990.850274491771, 4993.825216117419, 5027.497250275016, 4162.438070860456, 4205.453291072141, 4256.34026725858, 4264.061906380592, 4268.722533035405, 3682.4844521766972, 3693.9261214776093, 3698.7041036716996, 3729.5151630288433, 3738.0841693785196, 4305.9569404306185, 4307.5261721210645, 4317.892052698645, 4351.69538132334, 4355.7822108894425, 4943.060818444484, 5001.44984051754, 5032.899342013213, 5088.135017047037, 5096.566791822663, 4207.0, 4232.724872883315, 4232.746035237896, 4234.661227101825, 4279.40088387626, 4429.435403652537, 4432.889177770517, 4439.223135951195, 4471.709338892962, 4475.1049790042125, 4620.630349572026, 4760.119377915166, 4832.903341933072, 4839.346688197189, 4857.028594281087, 4895.412550493964, 4919.704817710805, 4920.630952678635, 4923.236898280772, 4958.157113290677, 4604.8388306409115, 4611.239145540948, 4620.653450991122, 4640.512746161605, 4668.463126740333, 4800.927986080142, 4845.685030473008, 4894.461609222912, 4895.143349913679, 4898.069366820293, 4945.307656927961, 4989.501049895127, 4990.4011518618, 4992.425871024879, 4992.650514463952, 4843.564079232886, 4858.732769697701, 4858.854234372974, 4863.440704318907, 4865.513448655106, 4838.056578967208, 4844.563989240985, 4865.829695960766, 4872.488388719134, 4954.900901982012, 4858.805647774191, 4859.222524396079, 4877.756112194447, 4891.29076283944, 4928.408590969107, 4906.828261010847, 4964.751762411937, 4985.950140498694, 4986.700797952134, 5015.924761128513, 4676.672632915664, 4758.024604955906, 4761.214399624023, 4767.09425209223, 4852.830150944841], "value": 4604.959597329665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.7282459853107, 587.9882402351953, 605.0561124645551, 610.7740136149625, 618.2858798088209, 32822.507662385055, 34053.829730851314, 34054.82972585137, 34160.829195853985, 34171.65828341716, 36965.26069478609, 37806.43290350647, 37818.81090594543, 37904.81047594758, 37946.430803537965, 7365.963170184142, 7615.238476152396, 7621.542707437571, 7629.694812207533, 7857.6856925722905, 7529.661165247549, 9800.803983920317, 10197.796044079114, 10198.949005254963, 10207.540660670287, 9867.210623150168, 9965.252606054539, 9971.75070623233, 9978.30151889368, 9981.800363992716, 7411.518251313647, 9784.217262618973, 9789.118979291863, 9843.753906152404, 9915.80168396628, 9720.368176068532, 9836.557354918974, 9874.061964113398, 9875.654352097643, 9875.901240987641, 33980.0, 34327.313453730785, 34337.14157146066, 34356.82821585901, 34366.14084647879, 2715.3618899558587, 2746.426817349729, 3228.0124482150422, 3237.14215732831, 3241.8216998065095, 28540.714592854012, 28541.0, 28877.42245155085, 29053.0, 29563.556546651816, 3410.7380269300515, 3425.6060553036223, 3516.279162771651, 3531.3820081485637, 3553.218291975761, 214469.0, 216875.0, 217514.0, 217646.0, 217692.0, 32337.838310808296, 50563.241551376756, 51164.74417627962, 51377.0, 51430.74284628553, 31658.208544786103, 31710.2072448186, 31786.841065794986, 31791.0, 31817.52273715896, 12068.698282542831, 12380.257184568954, 12387.566435174725, 12397.194182378296, 12408.317542535067, 9447.763805904908, 9627.90372096284, 9885.308028437941, 10111.898881011242, 10500.894991050145, 7917.0, 7942.245486678757, 7991.400644951652, 8070.596470176468, 8076.636551355203, 3135.7804953653026, 3180.666030066856, 3198.233527998265, 3212.2772376215166, 3227.4674678678225, 881.1320848963766, 903.3450748207497, 957.4590356448723, 990.8860481044628, 1000.4647513580345, 27074.864625676746, 27738.861305693343, 27755.722442775717, 28233.858830706125, 28398.574021389282, 969.9854502182473, 982.6511588386163, 1000.2748007694363, 1002.5989604158395, 1055.6516349604765, 14344.313238036048, 14594.562163135122, 14928.850711492963, 14973.475928342456, 15018.249087545579, 361359.0, 368469.0, 369563.0, 370029.0, 370467.0, 47310.0, 48081.75959120252, 48127.278090828666, 48144.0, 48152.5184748155, 1065.808154532176, 1155.4627098399285, 1161.5876363890698, 1229.5327775445273, 1257.905657075723, 25842.35394115162, 27764.60960384047, 28014.0, 28302.292442689097, 28344.71655283421, 38543.614563854004, 38906.61093389143, 39202.80398597989, 39204.0, 39262.0, 234776.0, 235270.0, 235679.0, 235699.0, 236329.0, 21915.0, 24211.273661790176, 25255.494890101727, 25417.364565886, 25548.361290967874, 35527.644723553465, 35706.10734731652, 36366.0, 36505.0, 37019.44470832886, 33070.66929330676, 33580.328393432486, 34483.82758086194, 34801.0, 34941.126471838405, 33728.66271337353, 33977.49033764446, 34109.317813644084, 34248.82875585606, 34327.65672343245, 34003.48994765031, 34645.13387165341, 34884.82557587297, 34967.65032349644, 35110.12224694403, 30026.69973300239, 30484.0, 30694.539581906734, 30708.385832283675, 30976.380472390876, 23807.0, 23852.64221036651, 23921.760782391953, 24165.0, 24204.273871783873], "value": 16123.012385500419, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.78146674928536, 379.66779068315225, 379.70003697079306, 381.1766584178176, 388.115097577523, 10392.896071039288, 11021.338719676805, 11025.062869656089, 11027.614033508838, 15811.762823557641, 16340.0, 16661.083640399775, 16997.405090821823, 17021.40425085122, 17041.57396065099, 4978.925316120243, 5664.603477756558, 5802.796902108427, 5810.56420768442, 5813.0, 5637.154426835967, 5814.738336774834, 5815.302163740357, 5817.767289308444, 5819.534437245032, 6559.409653131217, 6882.380585747282, 6929.514933954625, 6936.79189624312, 6937.306269373073, 6834.624095674736, 6903.965480172592, 6971.268016858207, 6972.1981972072845, 6975.895361569581, 6803.843346631084, 6919.0, 6924.480663950174, 6936.132983377078, 6979.511434199608, 22370.44073898149, 22653.886730566406, 22811.543769124524, 23187.420314492105, 23199.88400057989, 2003.9799602003939, 2007.8895660738654, 2013.5268211970176, 2047.4164863013968, 2075.294399904025, 14247.928760356132, 14362.138271703627, 14368.856311436857, 14476.927615361961, 14905.254737263094, 1831.5512699388735, 1897.4118023412786, 1956.2761778142037, 1987.652160871856, 1992.7907569705262, 82404.58797706034, 83251.0, 86225.0, 86228.11973461146, 86279.0, 15786.21068946571, 16221.756673649905, 16314.18429078565, 16395.836041639668, 16418.097004664618, 29760.55359169614, 29903.700962990526, 30167.698323016488, 30176.54735178974, 30178.69821301803, 8106.554139522383, 8457.112003239694, 8529.658813647384, 8654.826903461895, 8668.0, 6942.687579058955, 6983.825404364931, 7071.858562828817, 7082.0, 7089.680964356617, 8109.7161599343735, 8203.630836612367, 8281.668733250603, 8337.874931876027, 8385.371097167737, 2988.581598576201, 3201.935961280808, 3267.5588795512776, 3353.245519758035, 3420.7605467617027, 723.5297056912943, 777.7200207925142, 876.237673224299, 912.3112050401904, 944.1596978688972, 16027.919860400623, 16855.157242137844, 16912.492625221264, 16988.66022679564, 17241.741373879402, 873.6461732998146, 876.9386142970059, 891.2513488669549, 901.9458832469942, 905.4657751926395, 7990.840183196304, 9330.253579713606, 9392.389494682824, 9496.477693726772, 9631.662891798753, 385618.0, 395564.0, 398268.0, 401068.0, 402900.0, 55193.0, 71590.64204678943, 76090.61954690191, 78749.21250787418, 79937.60031199807, 912.5619702542684, 937.2970272295778, 957.2294303086082, 985.5466485416645, 987.3582171588381, 14581.661791162263, 15351.309191086651, 15568.844311556739, 15712.214389280261, 15715.921420392824, 34040.31919361649, 34463.310733785685, 34513.48229776606, 35564.822175888956, 36049.81975090108, 50592.241116382545, 50860.0, 51559.48440515697, 51618.741906290226, 52202.73898630482, 7513.098428188652, 7786.221377862168, 7813.335866451415, 7863.960680196562, 7881.093674227537, 10171.491425428847, 11311.717207069889, 11688.357140357362, 11705.122115841175, 12019.699507512032, 10226.6420675276, 10240.743981400525, 10259.7435064121, 10272.435016073889, 10554.419506927192, 9642.951785241028, 9863.408195508293, 10168.69493915154, 10253.538590763583, 10656.0, 10243.0, 10529.842052369373, 10592.470376481298, 10797.0, 10973.670789876316, 7788.688452461838, 7909.485883417559, 7952.729161671797, 8108.391870609846, 8121.0, 9510.191633710936, 9715.319927605, 9939.105480506789, 10054.447005414773, 10145.746356340855], "value": 9188.074849050266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.6079484962231, 1451.5572750311155, 1461.1671347332021, 1596.6088308364453, 1773.3970450046988, 6554.672266386679, 7675.577843218621, 7873.881891771628, 7891.487053341529, 7904.5652489113145, 7724.073111226647, 7726.806829829257, 7782.4163187761005, 7792.610369481532, 7811.101723301807, 1947.045947485736, 2234.4190510467315, 2258.4303908783404, 2290.919817806377, 2292.3695983604557, 2286.942826429344, 2308.8499247548857, 2312.4681323295654, 2312.6993490846166, 2320.0835669910375, 2168.826493880486, 2170.305502239284, 2216.7783221677782, 2217.1907253852387, 2218.5895609312247, 1898.1173754204292, 2156.762756096828, 2171.3160354488446, 2236.586231547169, 2239.4065572623267, 2205.911763529457, 2231.34175418252, 2237.876916769577, 2241.025154057974, 2241.8430709850318, 7713.65288562016, 7744.961275193645, 7770.961145194295, 7771.572563509005, 7775.261350171724, 4580.473245576768, 4708.529147085298, 4710.411198600175, 4712.858614241578, 4736.810527578893, 2805.6072149899032, 2810.6486689163853, 2936.8237905725723, 2940.2208414770103, 2965.4069186162637, 917.6833992272722, 922.7047344849651, 935.4387367579398, 938.4932136646203, 949.5774380400725, 10823.0, 10825.945870270676, 10850.565977360975, 10852.782944341068, 10856.72858178536, 4272.743635381887, 4302.397664326997, 4451.154280686659, 4466.865994020184, 4544.386507821468, 9252.444853308823, 9266.860997085048, 9268.860967085498, 9292.442453452815, 9293.581788819383, 4835.685680430761, 4837.129316722953, 4858.246971719389, 4858.7570621468785, 4861.173600487926, 3787.6212378762452, 4300.0, 4409.074094440203, 4416.9779151104685, 4440.777961101932, 3746.494223279822, 3775.811209439572, 3873.5545412277384, 3909.941350879682, 3910.6089391061237, 1235.7096082420624, 1254.4417734108417, 1256.3655354046148, 1260.3698150924538, 1272.7454509098031, 654.8952167653152, 668.301624802083, 677.8745932002595, 769.4267770511005, 775.693601027591, 5075.543201111917, 5139.640225184276, 5158.0, 5191.22131680251, 5203.037438073893, 418.98324067036975, 432.59336223949384, 435.13842591668674, 441.99116017679466, 443.691634314155, 3483.425234836224, 3489.8778542750883, 3489.8953031409096, 3590.5691317042124, 3598.3522965865873, 9670.661526846667, 10090.545925433225, 10152.23858210637, 10180.134688551409, 10202.438865862301, 10052.64815731446, 10058.245631577662, 10058.99410059003, 10065.547050382751, 10069.597216111273, 6996.475264355194, 7469.626518674045, 7517.924820751722, 7564.810879728051, 7591.4685971982535, 5198.090334191425, 5291.60312976536, 5323.680579165262, 5370.113931201308, 5388.326459192601, 9184.54077296119, 9291.349605527548, 9310.394824336396, 9316.813663726824, 9513.904860951301, 8847.46915185091, 9394.67118650844, 9531.38046027006, 9549.570269337757, 9688.5640146195, 6126.724297406717, 6151.292601350902, 6826.556273842184, 6841.247462778991, 6946.305369463013, 7500.662470188746, 7504.099508059068, 7504.311529905727, 7553.962230188814, 7576.810579735551, 6649.501287403367, 6826.692798823966, 6852.6916288768125, 6923.203831559234, 6958.269381714847, 6797.0, 6815.795526134224, 6869.072675188786, 6954.79135625932, 6974.197967233833, 6000.819975400745, 6053.424924632153, 6070.54470914692, 6139.877202456015, 6347.587406818542, 4520.389747384193, 4550.954490455186, 4589.701669391479, 4593.632509399174, 4629.4907560167685, 4502.0, 4565.452145742533, 4615.399998000238, 4625.098105869323, 4666.650001249852], "value": 4106.770606157217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.57416764864485, 318.8373929296059, 318.9952150717739, 322.08527781101697, 322.19451371571074, 4994.775235114419, 5194.402643695967, 5213.973930130349, 5293.0, 5296.073187192241, 4987.276844857493, 5189.636725429222, 5197.064528384889, 5202.8179013734525, 5213.540208741549, 4048.554658987516, 4051.4530538377235, 4060.675145988314, 4065.1463192729416, 4087.4890638670167, 3781.924361512768, 3814.82833272502, 4064.268431682296, 4074.22589707956, 4081.4898137732785, 4011.8997025074314, 4026.8187931543152, 4040.373742069984, 4041.7777022263763, 4043.1495795464125, 4018.557958624549, 4024.4969378827645, 4027.335489644205, 4030.3349947258666, 4032.0927791247027, 3462.065242384542, 3551.076720052779, 3552.3250582389524, 3556.822158892071, 3560.3235385276716, 4942.021672553593, 4955.479674634147, 4962.4045114586115, 4963.305137280783, 4978.352814134176, 4618.0, 4621.768911554443, 4623.676342656016, 4633.698809577367, 4645.303204519315, 5259.921101183485, 5452.591055670801, 5454.318210223722, 5454.509094181542, 5460.890782184374, 3829.329867273216, 3833.884983450501, 3837.347650899354, 3845.480860083881, 3846.7307288489815, 5692.686902220376, 5756.19413282145, 5773.278340207474, 5775.797847075332, 5788.5369170466265, 3809.6571308581806, 3929.76421414716, 3935.0, 3941.5664276929515, 3952.1107750756423, 3955.248502784462, 3983.382575700771, 3989.900252493711, 3993.0815912339745, 3998.7000974926996, 4564.634829213722, 4582.312653101994, 4592.609628181642, 4595.816167353269, 4607.838725644653, 5421.186821976735, 5441.156620723794, 5479.75341109651, 5500.937148569286, 5511.559075273968, 1362.8773410392914, 1370.4244217428504, 1376.800363947242, 1383.5503461375092, 1384.4047059764196, 913.5980168725739, 917.458669435355, 933.5285680731188, 934.6588495199339, 936.4802534593366, 4799.856004319806, 4809.110314591811, 4809.879753006203, 4811.542903424169, 4818.445878723922, 5678.744456499468, 5679.659220446786, 5683.658980461186, 5685.204071430003, 5701.116326969326, 4629.51390104041, 4751.2657879873595, 4788.808447662054, 4792.329073929653, 4809.759512024455, 3021.3353062326255, 3030.6211723534557, 3035.590195323647, 3043.710847469487, 3046.4211799757977, 5295.841124766263, 5305.151175811851, 5307.548858347083, 5310.283111779938, 5319.946800532022, 5649.350324712628, 5758.222639943638, 5787.102999035156, 5799.39106393831, 5811.476967072984, 5263.868403289948, 5274.815381461631, 5278.8944221116135, 5289.3652761668845, 5296.0, 5489.149181876815, 5591.692456914909, 5599.776008959596, 5635.830925072254, 5662.858428539154, 5508.724563771715, 5512.91730624049, 5524.226608274765, 5533.170024496197, 5544.584156188222, 5258.106121959199, 5272.130098533699, 5281.996420680059, 5311.839455523957, 5341.172118321666, 3553.8578456861437, 3690.1697118148204, 3744.4008958566496, 3804.372278574004, 3809.1239015026144, 5526.253955716088, 5621.662700237999, 5638.407967163389, 5658.660480371191, 5659.858503537444, 5456.317960254968, 5457.808976685797, 5468.878879829545, 5472.890542189054, 5485.945140548543, 5213.165893457029, 5450.563954883521, 5462.863428414322, 5463.972680136574, 5542.69515176653, 5402.9459705404015, 5425.321834770653, 5459.972700136474, 5465.180222966428, 5483.506484416422, 5522.625271133451, 5532.280803495681, 5532.972335138459, 5548.167774833807, 5550.114919556246, 5185.196294574347, 5384.865378365572, 5405.108157154025, 5416.133418652997, 5425.104857698436], "value": 4098.787076687462, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.151166506871, 681.6251061915945, 686.680693477533, 691.1602403080253, 717.4188906985339, 11562.710932226699, 11918.404079796019, 11927.343996080212, 11929.1649584529, 11963.521459141635, 12042.75914481712, 12913.870861291385, 13825.101368411046, 13829.585112446617, 13867.514636987707, 628.8710814283083, 777.9260970207821, 782.2138750555683, 785.8467598818232, 787.0358810457201, 635.6948664640975, 641.9871602567946, 643.2313385504324, 752.5559919647407, 778.6807408962327, 828.718235799828, 829.1998221716043, 830.1947111302028, 830.8462934357133, 831.476170012891, 824.1470078468816, 824.3487644760631, 824.5011767880466, 824.6000689665508, 824.9876251856227, 482.27899290560487, 590.7400743672813, 604.6734763227852, 605.8757954619336, 607.0136028952951, 12734.936325318407, 12788.744225115539, 12798.872011279955, 12832.615021549369, 12876.420561074774, 11762.294262344287, 12119.091068169835, 12234.388280585936, 12303.569375071918, 12450.81323780144, 9640.276979226586, 9922.751931201705, 9973.301868869183, 10069.043440873105, 10131.949340253252, 3272.590926134233, 3273.885414010498, 3317.4526203176447, 3318.3363327334387, 3408.233147541808, 46545.04367128798, 46993.530064699255, 47355.289670654965, 47446.5255347449, 47507.99999999965, 9388.389754665925, 9463.148316651534, 9499.0, 9552.617895284111, 9575.808483830284, 17032.14839258057, 17127.914360428367, 17206.1396930153, 17235.74146387805, 17243.655126897393, 6464.547481676332, 6504.45292620864, 6559.24568674599, 6568.080468734285, 6647.66761661915, 3712.294664013829, 3758.4926034985474, 3791.279656865187, 3799.335116354682, 3854.672352849983, 2864.527352986734, 2923.5468502382164, 2924.312786495172, 2926.1075372011314, 2926.2245504941206, 485.16309366343484, 489.56917912237714, 501.4809671989473, 505.36576596371316, 523.3275241314968, 497.2367416016397, 561.1526594841819, 575.6488541989384, 586.0827804485966, 602.6504627316147, 7279.854402911912, 7341.3392794648735, 7496.962515187498, 7560.281773231534, 7802.414818888606, 501.98849318623, 548.3310361359136, 583.5769067426082, 602.6896148483535, 624.1199908129606, 3728.12389088564, 3785.2033862896656, 3822.503074600284, 3913.5108111486065, 3921.7254792164845, 51801.48198518042, 52272.21591676128, 52369.21446178311, 52373.905043798586, 52390.738046309525, 48126.75936620295, 48172.27741583879, 48583.0, 49403.258951115764, 49471.0, 43606.127877442275, 44143.33784993228, 44324.77837610856, 44997.32504012442, 45164.54835451669, 7165.713371465292, 7411.96294018548, 7429.0, 7464.440166987389, 7533.1336896257635, 29461.410771784875, 29731.256718582208, 30133.69866301309, 30706.232344191572, 30867.536986944764, 36582.26835463329, 39417.802910985265, 39633.80183099066, 39803.60196398115, 39806.402903957045, 8911.866322005304, 9097.272218222393, 9161.450312981242, 9176.862347064665, 9218.677346292847, 9975.301728878909, 10043.949780251345, 10079.042490963348, 10109.79780404373, 10254.436006019741, 9567.0, 9717.85423218638, 9807.950960245153, 9906.405615663083, 9997.0, 10401.271910966463, 10599.8940010602, 10767.838482422927, 10823.350598964087, 11331.603393881174, 10275.794484110425, 10324.587016519255, 10389.428581428094, 10516.737081573021, 10746.570137194425, 8637.91362086371, 8913.777155571162, 9226.630934762534, 9260.907390926004, 9383.812323753624, 8724.43291186071, 8940.418872773249, 8972.865407019031, 9118.908810911806, 9276.25789936817], "value": 5765.589091781483, "unit": "score"}], "name": "dromaeo_css", "value": 6360.48617800365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 106.0, 111.0, 113.0, 113.0, 100.0, 112.0, 112.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 135.0, 160.0, 189.0, 131.0, 155.0, 156.0, 140.0, 209.0, 138.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 162.0, 163.0, 161.0, 160.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 127.0, 117.0, 77.0, 73.0, 74.0, 121.0, 106.0, 74.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 145.0, 93.0, 94.0, 94.0, 139.0, 94.0, 94.0, 149.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 64.0, 65.0, 64.0, 64.0, 87.0, 61.0, 64.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 78.0, 79.0, 79.0, 79.0, 80.0, 81.0, 81.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 133.0, 141.0, 130.0, 128.0, 139.0, 131.0, 166.0, 145.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 182.0, 179.0, 178.0, 180.0, 187.0, 181.0, 177.0, 174.0, 175.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 74.0, 73.0, 72.0, 73.0, 71.0, 71.0, 76.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1587.6, "alertThreshold": 2.0}]} 05:41:43 INFO - Return code: 0 05:41:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:43 ERROR - # TBPL SUCCESS # 05:41:43 INFO - Running post-action listener: _resource_record_post_action 05:41:43 INFO - Running post-run listener: _resource_record_post_run 05:41:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 517558272; Read time: 200; Write time: 544496 05:41:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234045440; Read time: 156; Write time: 287752 05:41:44 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282914816; Read time: 44; Write time: 256744 05:41:44 INFO - Running post-run listener: _upload_blobber_files 05:41:44 INFO - Blob upload gear active. 05:41:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:44 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:44 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:44 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:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:46 INFO - (blobuploader) - INFO - Done attempting. 05:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:47 INFO - (blobuploader) - INFO - Done attempting. 05:41:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:47 INFO - Return code: 0 05:41:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757e9623a7b8334c3087f6ebdf2fe866dc0c12a3f4566e7664e77bfb6c94ab647330373ca7e4ec0aa03f50a39e778537000f37549e9d449b8570e06cfc6d226d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ccbd036910c274c473a9e2cce8bd0ca0578e72562a4fbebb9ea3d6dbf0a05ca73397c9d70c1cebc4d0c54344079016c9f823d348ebd254299a397c2832a432f"} 05:41:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:47 INFO - Contents: 05:41:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/757e9623a7b8334c3087f6ebdf2fe866dc0c12a3f4566e7664e77bfb6c94ab647330373ca7e4ec0aa03f50a39e778537000f37549e9d449b8570e06cfc6d226d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ccbd036910c274c473a9e2cce8bd0ca0578e72562a4fbebb9ea3d6dbf0a05ca73397c9d70c1cebc4d0c54344079016c9f823d348ebd254299a397c2832a432f"} 05:41:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:47 INFO - Copying logs to upload dir... 05:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.160600 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-25 05:41:46.643059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:46.648259) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 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/757e9623a7b8334c3087f6ebdf2fe866dc0c12a3f4566e7664e77bfb6c94ab647330373ca7e4ec0aa03f50a39e778537000f37549e9d449b8570e06cfc6d226d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ccbd036910c274c473a9e2cce8bd0ca0578e72562a4fbebb9ea3d6dbf0a05ca73397c9d70c1cebc4d0c54344079016c9f823d348ebd254299a397c2832a432f"} 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.011312 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/757e9623a7b8334c3087f6ebdf2fe866dc0c12a3f4566e7664e77bfb6c94ab647330373ca7e4ec0aa03f50a39e778537000f37549e9d449b8570e06cfc6d226d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ccbd036910c274c473a9e2cce8bd0ca0578e72562a4fbebb9ea3d6dbf0a05ca73397c9d70c1cebc4d0c54344079016c9f823d348ebd254299a397c2832a432f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:46.673623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:46.674000) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461586868.925305-293036681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:41:46.760359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:41:46.760865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:41:46.761426) ========= ========= Total master_lag: 0.17 =========