builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1461611972.3 results: success (0) buildid: 20160425113506 builduid: 1445a4f8deb94df187e81eff5838680b revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.304275) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.304687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.304962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.321387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.321877) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 12:19:32-- 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% 46.6M=0s 2016-04-25 12:19:32 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.064684 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.512175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.512621) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014643 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.541361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:32.541722) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --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 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 12:19:32,705 truncating revision to first 12 chars 2016-04-25 12:19:32,705 Setting DEBUG logging. 2016-04-25 12:19:32,705 attempt 1/10 2016-04-25 12:19:32,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/14952428292c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 12:19:32,968 unpacking tar archive at: fx-team-14952428292c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:33.117623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:33.117984) ========= script_repo_revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:33.118531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:33.119039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:33.136169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-25 12:19:33.136602) ========= /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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:33 INFO - MultiFileLogger online at 20160425 12:19:33 in /builds/slave/test 12:19:33 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 12:19:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:33 INFO - {'append_to_log': False, 12:19:33 INFO - 'base_work_dir': '/builds/slave/test', 12:19:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:19:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:33 INFO - 'branch': 'Fx-Team-Non-PGO', 12:19:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:33 INFO - 'config_files': ('talos/linux_config.py',), 12:19:33 INFO - 'default_actions': ('clobber', 12:19:33 INFO - 'read-buildbot-config', 12:19:33 INFO - 'download-and-extract', 12:19:33 INFO - 'populate-webroot', 12:19:33 INFO - 'create-virtualenv', 12:19:33 INFO - 'install', 12:19:33 INFO - 'run-tests'), 12:19:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:33 INFO - 'download_minidump_stackwalk': True, 12:19:33 INFO - 'download_symbols': 'ondemand', 12:19:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:33 INFO - 'installer_path': 'installer.exe', 12:19:33 INFO - 'log_level': 'info', 12:19:33 INFO - 'log_name': 'talos', 12:19:33 INFO - 'log_to_console': True, 12:19:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:33 INFO - 'opt_config_files': (), 12:19:33 INFO - 'pip_index': False, 12:19:33 INFO - 'sps_profile': False, 12:19:33 INFO - 'sps_profile_interval': 0, 12:19:33 INFO - 'suite': 'dromaeojs', 12:19:33 INFO - 'system_bits': '32', 12:19:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:33 INFO - 'title': 'talos-linux64-ix-046', 12:19:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:33 INFO - 'use_talos_json': True, 12:19:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:33 INFO - 'work_dir': 'build'} 12:19:33 INFO - ##### 12:19:33 INFO - ##### Running clobber step. 12:19:33 INFO - ##### 12:19:33 INFO - Running pre-action listener: _resource_record_pre_action 12:19:33 INFO - Running main action method: clobber 12:19:33 INFO - rmtree: /builds/slave/test/build 12:19:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:33 INFO - Running post-action listener: _resource_record_post_action 12:19:33 INFO - ##### 12:19:33 INFO - ##### Running read-buildbot-config step. 12:19:33 INFO - ##### 12:19:33 INFO - Running pre-action listener: _resource_record_pre_action 12:19:33 INFO - Running main action method: read_buildbot_config 12:19:33 INFO - Using buildbot properties: 12:19:33 INFO - { 12:19:33 INFO - "project": "", 12:19:33 INFO - "product": "firefox", 12:19:33 INFO - "script_repo_revision": "production", 12:19:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:19:33 INFO - "repository": "", 12:19:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:19:33 INFO - "buildid": "20160425113506", 12:19:33 INFO - "pgo_build": "False", 12:19:33 INFO - "basedir": "/builds/slave/test", 12:19:33 INFO - "buildnumber": 2884, 12:19:33 INFO - "slavename": "talos-linux64-ix-046", 12:19:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:19:33 INFO - "platform": "ubuntu64_hw", 12:19:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:19:33 INFO - "branch": "fx-team", 12:19:33 INFO - "repo_path": "integration/fx-team", 12:19:33 INFO - "revision": "14952428292c90aa00c28fdfb1f1e79bd8257ce2", 12:19:33 INFO - "stage_platform": "linux64", 12:19:33 INFO - "builduid": "1445a4f8deb94df187e81eff5838680b", 12:19:33 INFO - "slavebuilddir": "test" 12:19:33 INFO - } 12:19:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:19:33 INFO - Running post-action listener: _resource_record_post_action 12:19:33 INFO - ##### 12:19:33 INFO - ##### Running download-and-extract step. 12:19:33 INFO - ##### 12:19:33 INFO - Running pre-action listener: _resource_record_pre_action 12:19:33 INFO - Running main action method: download_and_extract 12:19:33 INFO - mkdir: /builds/slave/test/build/tests 12:19:33 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')]} 12:19:33 INFO - https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:34 INFO - Downloaded 1361 bytes. 12:19:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:34 INFO - Using the following test package requirements: 12:19:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:19:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'jsshell-linux-x86_64.zip'], 12:19:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:19:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:19:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:34 INFO - https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:35 INFO - Downloaded 22288221 bytes. 12:19:35 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'] 12:19:35 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 12:19:37 INFO - Return code: 0 12:19:37 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 12:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:37 INFO - https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:19:59 INFO - Downloaded 22288221 bytes. 12:19:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:20:00 INFO - Return code: 0 12:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:00 INFO - https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:20:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:20:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:20:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:20:01 INFO - Downloaded 10840145 bytes. 12:20:01 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'] 12:20:01 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 12:20:02 INFO - Return code: 0 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:02 INFO - https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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 12:20:03 INFO - Downloaded 54812834 bytes. 12:20:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:20:03 INFO - mkdir: /builds/slave/test/properties 12:20:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:20:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:20:03 INFO - Contents: 12:20:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:20:04 INFO - Running post-action listener: _resource_record_post_action 12:20:04 INFO - Running post-action listener: set_extra_try_arguments 12:20:04 INFO - ##### 12:20:04 INFO - ##### Running populate-webroot step. 12:20:04 INFO - ##### 12:20:04 INFO - Running pre-action listener: _resource_record_pre_action 12:20:04 INFO - Running main action method: populate_webroot 12:20:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:20:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:20:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:20:04 INFO - '--tppagecycles', 12:20:04 INFO - '7'], 12:20:04 INFO - 'tests': ['tsvgm']}}, 12:20:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:20:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:20:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:20:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:20:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['damp', 'tps']}, 12:20:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'tests': ['damp', 'tps']}, 12:20:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['dromaeo_dom']}, 12:20:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:20:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['a11yr', 12:20:04 INFO - 'ts_paint', 12:20:04 INFO - 'tpaint', 12:20:04 INFO - 'sessionrestore', 12:20:04 INFO - 'sessionrestore_no_auto_restore', 12:20:04 INFO - 'tabpaint']}, 12:20:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['tsvgx', 12:20:04 INFO - 'tsvgr_opacity', 12:20:04 INFO - 'tart', 12:20:04 INFO - 'tscrollx', 12:20:04 INFO - 'cart']}, 12:20:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:20:04 INFO - 'tsvgr_opacity', 12:20:04 INFO - 'tart', 12:20:04 INFO - 'tscrollx', 12:20:04 INFO - 'cart']}, 12:20:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'talos_options': ['--disable-e10s'], 12:20:04 INFO - 'tests': ['tp5o']}, 12:20:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'tests': ['tp5o']}, 12:20:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'talos_options': ['--disable-e10s', 12:20:04 INFO - '--xperf_path', 12:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:04 INFO - 'tests': ['tp5n']}, 12:20:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:04 INFO - 'talos_options': ['--xperf_path', 12:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:04 INFO - 'tests': ['tp5n']}}, 12:20:04 INFO - 'talos.zip': {'path': '', 12:20:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:20:04 INFO - Running post-action listener: _resource_record_post_action 12:20:04 INFO - ##### 12:20:04 INFO - ##### Running create-virtualenv step. 12:20:04 INFO - ##### 12:20:04 INFO - Running pre-action listener: _resource_record_pre_action 12:20:04 INFO - Running main action method: create_virtualenv 12:20:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:20:04 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 12:20:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:20:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:20:04 INFO - Using real prefix '/usr' 12:20:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:20:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:20:06 INFO - Installing pip.................done. 12:20:06 INFO - Return code: 0 12:20:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:06 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:06 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 12:20:06 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 12:20:06 INFO - Using env: {'DISPLAY': ':0', 12:20:06 INFO - 'HOME': '/home/cltbld', 12:20:06 INFO - 'LANG': 'en_US.UTF-8', 12:20:06 INFO - 'LANGUAGE': 'en_US:en', 12:20:06 INFO - 'LOGNAME': 'cltbld', 12:20:06 INFO - 'MAIL': '/var/mail/cltbld', 12:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:06 INFO - 'MOZ_NO_REMOTE': '1', 12:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:06 INFO - 'NO_EM_RESTART': '1', 12:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:06 INFO - 'PWD': '/builds/slave/test', 12:20:06 INFO - 'SHELL': '/bin/bash', 12:20:06 INFO - 'SHLVL': '1', 12:20:06 INFO - 'TERM': 'linux', 12:20:06 INFO - 'TMOUT': '86400', 12:20:06 INFO - 'USER': 'cltbld', 12:20:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:06 INFO - '_': '/tools/buildbot/bin/python'} 12:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:07 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 12:20:07 INFO - Cleaning up... 12:20:07 INFO - Return code: 0 12:20:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:07 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:07 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 12:20:07 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 12:20:07 INFO - Using env: {'DISPLAY': ':0', 12:20:07 INFO - 'HOME': '/home/cltbld', 12:20:07 INFO - 'LANG': 'en_US.UTF-8', 12:20:07 INFO - 'LANGUAGE': 'en_US:en', 12:20:07 INFO - 'LOGNAME': 'cltbld', 12:20:07 INFO - 'MAIL': '/var/mail/cltbld', 12:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:07 INFO - 'MOZ_NO_REMOTE': '1', 12:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:07 INFO - 'NO_EM_RESTART': '1', 12:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:07 INFO - 'PWD': '/builds/slave/test', 12:20:07 INFO - 'SHELL': '/bin/bash', 12:20:07 INFO - 'SHLVL': '1', 12:20:07 INFO - 'TERM': 'linux', 12:20:07 INFO - 'TMOUT': '86400', 12:20:07 INFO - 'USER': 'cltbld', 12:20:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:07 INFO - '_': '/tools/buildbot/bin/python'} 12:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:07 INFO - Downloading/unpacking psutil>=0.7.1 12:20:07 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 12:20:07 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 12:20:07 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 12:20:07 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 12:20:07 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 12:20:07 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 12:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:20:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:09 INFO - Installing collected packages: psutil 12:20:09 INFO - Running setup.py install for psutil 12:20:09 INFO - building 'psutil._psutil_linux' extension 12:20:09 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 12:20:09 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 12:20:09 INFO - building 'psutil._psutil_posix' extension 12:20:09 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 12:20:09 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 12:20:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:09 INFO - Successfully installed psutil 12:20:09 INFO - Cleaning up... 12:20:09 INFO - Return code: 0 12:20:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:20:09 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')]} 12:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 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')]} 12:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:09 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 12:20:09 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 12:20:09 INFO - Using env: {'DISPLAY': ':0', 12:20:09 INFO - 'HOME': '/home/cltbld', 12:20:09 INFO - 'LANG': 'en_US.UTF-8', 12:20:09 INFO - 'LANGUAGE': 'en_US:en', 12:20:09 INFO - 'LOGNAME': 'cltbld', 12:20:09 INFO - 'MAIL': '/var/mail/cltbld', 12:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:09 INFO - 'MOZ_NO_REMOTE': '1', 12:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:09 INFO - 'NO_EM_RESTART': '1', 12:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:09 INFO - 'PWD': '/builds/slave/test', 12:20:09 INFO - 'SHELL': '/bin/bash', 12:20:09 INFO - 'SHLVL': '1', 12:20:09 INFO - 'TERM': 'linux', 12:20:09 INFO - 'TMOUT': '86400', 12:20:09 INFO - 'USER': 'cltbld', 12:20:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:09 INFO - '_': '/tools/buildbot/bin/python'} 12:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:20:10 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 12:20:10 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 12:20:10 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 12:20:10 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 12:20:10 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 12:20:10 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 12:20:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:20:11 INFO - Installing collected packages: mozsystemmonitor 12:20:11 INFO - Running setup.py install for mozsystemmonitor 12:20:12 INFO - Successfully installed mozsystemmonitor 12:20:12 INFO - Cleaning up... 12:20:12 INFO - Return code: 0 12:20:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:12 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:12 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 12:20:12 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 12:20:12 INFO - Using env: {'DISPLAY': ':0', 12:20:12 INFO - 'HOME': '/home/cltbld', 12:20:12 INFO - 'LANG': 'en_US.UTF-8', 12:20:12 INFO - 'LANGUAGE': 'en_US:en', 12:20:12 INFO - 'LOGNAME': 'cltbld', 12:20:12 INFO - 'MAIL': '/var/mail/cltbld', 12:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:12 INFO - 'MOZ_NO_REMOTE': '1', 12:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:12 INFO - 'NO_EM_RESTART': '1', 12:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:12 INFO - 'PWD': '/builds/slave/test', 12:20:12 INFO - 'SHELL': '/bin/bash', 12:20:12 INFO - 'SHLVL': '1', 12:20:12 INFO - 'TERM': 'linux', 12:20:12 INFO - 'TMOUT': '86400', 12:20:12 INFO - 'USER': 'cltbld', 12:20:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:12 INFO - '_': '/tools/buildbot/bin/python'} 12:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - Downloading blobuploader-1.2.4.tar.gz 12:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:20:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:20:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - Downloading docopt-0.6.1.tar.gz 12:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:20:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:20:14 INFO - Running setup.py install for blobuploader 12:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:20:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:20:15 INFO - Running setup.py install for requests 12:20:15 INFO - Running setup.py install for docopt 12:20:15 INFO - Successfully installed blobuploader requests docopt 12:20:15 INFO - Cleaning up... 12:20:15 INFO - Return code: 0 12:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:15 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:15 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 12:20:15 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 12:20:15 INFO - Using env: {'DISPLAY': ':0', 12:20:15 INFO - 'HOME': '/home/cltbld', 12:20:15 INFO - 'LANG': 'en_US.UTF-8', 12:20:15 INFO - 'LANGUAGE': 'en_US:en', 12:20:15 INFO - 'LOGNAME': 'cltbld', 12:20:15 INFO - 'MAIL': '/var/mail/cltbld', 12:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:15 INFO - 'MOZ_NO_REMOTE': '1', 12:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:15 INFO - 'NO_EM_RESTART': '1', 12:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:15 INFO - 'PWD': '/builds/slave/test', 12:20:15 INFO - 'SHELL': '/bin/bash', 12:20:15 INFO - 'SHLVL': '1', 12:20:15 INFO - 'TERM': 'linux', 12:20:15 INFO - 'TMOUT': '86400', 12:20:15 INFO - 'USER': 'cltbld', 12:20:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:15 INFO - '_': '/tools/buildbot/bin/python'} 12:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:15 INFO - Running setup.py (path:/tmp/pip-3NmLGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:15 INFO - Running setup.py (path:/tmp/pip-MKGQ8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:15 INFO - Running setup.py (path:/tmp/pip-uFuSi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:15 INFO - Running setup.py (path:/tmp/pip-8StZJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:16 INFO - Running setup.py (path:/tmp/pip-vbIyDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:16 INFO - Running setup.py (path:/tmp/pip-JdNsUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:16 INFO - Running setup.py (path:/tmp/pip-AiG1Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:16 INFO - Running setup.py (path:/tmp/pip-Kslcso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:16 INFO - Running setup.py (path:/tmp/pip-M20NX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:16 INFO - Running setup.py (path:/tmp/pip-7E7YFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:16 INFO - Running setup.py (path:/tmp/pip-EBskv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:16 INFO - Running setup.py (path:/tmp/pip-QJlII0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:16 INFO - Running setup.py (path:/tmp/pip-CiSA0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:16 INFO - Running setup.py (path:/tmp/pip-DXyOcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:16 INFO - Running setup.py (path:/tmp/pip-HhPcmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:16 INFO - Running setup.py (path:/tmp/pip-N7sEUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:16 INFO - Running setup.py (path:/tmp/pip-Oh7_mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:20:16 INFO - Running setup.py install for manifestparser 12:20:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozcrash 12:20:17 INFO - Running setup.py install for mozdebug 12:20:17 INFO - Running setup.py install for mozdevice 12:20:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozfile 12:20:17 INFO - Running setup.py install for mozhttpd 12:20:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozinfo 12:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozInstall 12:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozleak 12:20:17 INFO - Running setup.py install for mozlog 12:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for moznetwork 12:20:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozprocess 12:20:18 INFO - Running setup.py install for mozprofile 12:20:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozrunner 12:20:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozscreenshot 12:20:18 INFO - Running setup.py install for moztest 12:20:18 INFO - Running setup.py install for mozversion 12:20:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:20:18 INFO - Cleaning up... 12:20:18 INFO - Return code: 0 12:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:18 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:18 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 12:20:18 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 12:20:18 INFO - Using env: {'DISPLAY': ':0', 12:20:18 INFO - 'HOME': '/home/cltbld', 12:20:18 INFO - 'LANG': 'en_US.UTF-8', 12:20:18 INFO - 'LANGUAGE': 'en_US:en', 12:20:18 INFO - 'LOGNAME': 'cltbld', 12:20:18 INFO - 'MAIL': '/var/mail/cltbld', 12:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:18 INFO - 'MOZ_NO_REMOTE': '1', 12:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:18 INFO - 'NO_EM_RESTART': '1', 12:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:18 INFO - 'PWD': '/builds/slave/test', 12:20:18 INFO - 'SHELL': '/bin/bash', 12:20:18 INFO - 'SHLVL': '1', 12:20:18 INFO - 'TERM': 'linux', 12:20:18 INFO - 'TMOUT': '86400', 12:20:18 INFO - 'USER': 'cltbld', 12:20:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:18 INFO - '_': '/tools/buildbot/bin/python'} 12:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:18 INFO - Running setup.py (path:/tmp/pip-iO2Hfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:19 INFO - Running setup.py (path:/tmp/pip-gsD_VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:19 INFO - Running setup.py (path:/tmp/pip-ReIV_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:19 INFO - Running setup.py (path:/tmp/pip-WPZc4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:19 INFO - Running setup.py (path:/tmp/pip-8gJK9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:19 INFO - Running setup.py (path:/tmp/pip-Jn26d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:19 INFO - Running setup.py (path:/tmp/pip-m5Jy9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:19 INFO - Running setup.py (path:/tmp/pip-GukCw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:19 INFO - Running setup.py (path:/tmp/pip-fcaxC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:19 INFO - Running setup.py (path:/tmp/pip-Sq4seu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:19 INFO - Running setup.py (path:/tmp/pip-rQDtDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:19 INFO - Running setup.py (path:/tmp/pip-DVUI3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:19 INFO - Running setup.py (path:/tmp/pip-HXeBqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:19 INFO - Running setup.py (path:/tmp/pip-GU3l4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:19 INFO - Running setup.py (path:/tmp/pip-tvOlO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:20 INFO - Running setup.py (path:/tmp/pip-ADU7Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:20 INFO - Running setup.py (path:/tmp/pip-LNv3wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:20 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)) 12:20:20 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)) 12:20:20 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)) 12:20:20 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)) 12:20:20 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)) 12:20:20 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)) 12:20:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:20 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 12:20:20 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 12:20:20 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 12:20:20 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 12:20:20 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 12:20:20 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 12:20:22 INFO - Downloading blessings-1.6.tar.gz 12:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:20:22 INFO - Installing collected packages: blessings 12:20:22 INFO - Running setup.py install for blessings 12:20:22 INFO - Successfully installed blessings 12:20:22 INFO - Cleaning up... 12:20:22 INFO - Return code: 0 12:20:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:22 INFO - Reading from file tmpfile_stdout 12:20:22 INFO - Current package versions: 12:20:22 INFO - argparse == 1.2.1 12:20:22 INFO - blessings == 1.6 12:20:22 INFO - blobuploader == 1.2.4 12:20:22 INFO - docopt == 0.6.1 12:20:22 INFO - manifestparser == 1.1 12:20:22 INFO - mozInstall == 1.12 12:20:22 INFO - mozcrash == 0.17 12:20:22 INFO - mozdebug == 0.1 12:20:22 INFO - mozdevice == 0.48 12:20:22 INFO - mozfile == 1.2 12:20:22 INFO - mozhttpd == 0.7 12:20:22 INFO - mozinfo == 0.9 12:20:22 INFO - mozleak == 0.1 12:20:22 INFO - mozlog == 3.1 12:20:22 INFO - moznetwork == 0.27 12:20:22 INFO - mozprocess == 0.22 12:20:22 INFO - mozprofile == 0.28 12:20:22 INFO - mozrunner == 6.11 12:20:22 INFO - mozscreenshot == 0.1 12:20:22 INFO - mozsystemmonitor == 0.0 12:20:22 INFO - moztest == 0.7 12:20:22 INFO - mozversion == 1.4 12:20:22 INFO - psutil == 3.1.1 12:20:22 INFO - requests == 1.2.3 12:20:22 INFO - wsgiref == 0.1.2 12:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:22 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:22 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 12:20:22 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 12:20:22 INFO - Using env: {'DISPLAY': ':0', 12:20:22 INFO - 'HOME': '/home/cltbld', 12:20:22 INFO - 'LANG': 'en_US.UTF-8', 12:20:22 INFO - 'LANGUAGE': 'en_US:en', 12:20:22 INFO - 'LOGNAME': 'cltbld', 12:20:22 INFO - 'MAIL': '/var/mail/cltbld', 12:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:22 INFO - 'MOZ_NO_REMOTE': '1', 12:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:22 INFO - 'NO_EM_RESTART': '1', 12:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:22 INFO - 'PWD': '/builds/slave/test', 12:20:22 INFO - 'SHELL': '/bin/bash', 12:20:22 INFO - 'SHLVL': '1', 12:20:22 INFO - 'TERM': 'linux', 12:20:22 INFO - 'TMOUT': '86400', 12:20:22 INFO - 'USER': 'cltbld', 12:20:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:22 INFO - '_': '/tools/buildbot/bin/python'} 12:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 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)) 12:20:22 INFO - Cleaning up... 12:20:22 INFO - Return code: 0 12:20:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:22 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:22 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 12:20:22 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 12:20:22 INFO - Using env: {'DISPLAY': ':0', 12:20:22 INFO - 'HOME': '/home/cltbld', 12:20:22 INFO - 'LANG': 'en_US.UTF-8', 12:20:22 INFO - 'LANGUAGE': 'en_US:en', 12:20:22 INFO - 'LOGNAME': 'cltbld', 12:20:22 INFO - 'MAIL': '/var/mail/cltbld', 12:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:22 INFO - 'MOZ_NO_REMOTE': '1', 12:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:22 INFO - 'NO_EM_RESTART': '1', 12:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:22 INFO - 'PWD': '/builds/slave/test', 12:20:22 INFO - 'SHELL': '/bin/bash', 12:20:22 INFO - 'SHLVL': '1', 12:20:22 INFO - 'TERM': 'linux', 12:20:22 INFO - 'TMOUT': '86400', 12:20:22 INFO - 'USER': 'cltbld', 12:20:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:22 INFO - '_': '/tools/buildbot/bin/python'} 12:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:22 INFO - Downloading/unpacking jsonschema 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:20:24 INFO - Downloading/unpacking functools32 (from jsonschema) 12:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:20:25 INFO - warning: no files found matching '*.txt' 12:20:25 INFO - no previously-included directories found matching 'build' 12:20:25 INFO - no previously-included directories found matching 'dist' 12:20:25 INFO - no previously-included directories found matching '.git*' 12:20:25 INFO - Installing collected packages: jsonschema, functools32 12:20:25 INFO - Running setup.py install for functools32 12:20:25 INFO - warning: no files found matching '*.txt' 12:20:25 INFO - no previously-included directories found matching 'build' 12:20:25 INFO - no previously-included directories found matching 'dist' 12:20:25 INFO - no previously-included directories found matching '.git*' 12:20:25 INFO - Successfully installed jsonschema functools32 12:20:25 INFO - Cleaning up... 12:20:25 INFO - Return code: 0 12:20:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:20:25 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')]} 12:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:25 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')]} 12:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:25 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 0x7f3237e21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', '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 12:20:25 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 12:20:25 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 12:20:25 INFO - Using env: {'DISPLAY': ':0', 12:20:25 INFO - 'HOME': '/home/cltbld', 12:20:25 INFO - 'LANG': 'en_US.UTF-8', 12:20:25 INFO - 'LANGUAGE': 'en_US:en', 12:20:25 INFO - 'LOGNAME': 'cltbld', 12:20:25 INFO - 'MAIL': '/var/mail/cltbld', 12:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:25 INFO - 'MOZ_NO_REMOTE': '1', 12:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:25 INFO - 'NO_EM_RESTART': '1', 12:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:25 INFO - 'PWD': '/builds/slave/test', 12:20:25 INFO - 'SHELL': '/bin/bash', 12:20:25 INFO - 'SHLVL': '1', 12:20:25 INFO - 'TERM': 'linux', 12:20:25 INFO - 'TMOUT': '86400', 12:20:25 INFO - 'USER': 'cltbld', 12:20:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:25 INFO - '_': '/tools/buildbot/bin/python'} 12:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:25 INFO - Downloading/unpacking flake8 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:20:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:20:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:20:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:20:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:20:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:20:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:20:28 INFO - no previously-included directories found matching 'docs/_build' 12:20:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:20:28 INFO - Running setup.py install for pep8 12:20:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:20:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:20:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:20:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:20:28 INFO - no previously-included directories found matching 'docs/_build' 12:20:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:20:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:20:28 INFO - Cleaning up... 12:20:28 INFO - Return code: 0 12:20:28 INFO - Running post-action listener: _resource_record_post_action 12:20:28 INFO - Running post-action listener: _start_resource_monitoring 12:20:28 INFO - Starting resource monitoring. 12:20:28 INFO - ##### 12:20:28 INFO - ##### Running install step. 12:20:28 INFO - ##### 12:20:28 INFO - Running pre-action listener: _resource_record_pre_action 12:20:28 INFO - Running main action method: install 12:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:28 INFO - Reading from file tmpfile_stdout 12:20:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:28 INFO - Reading from file tmpfile_stdout 12:20:28 INFO - Output received: 12:20:28 INFO - Usage: mozinstall [options] installer 12:20:28 INFO - Options: 12:20:28 INFO - -h, --help show this help message and exit 12:20:28 INFO - -d DEST, --destination=DEST 12:20:28 INFO - Directory to install application into. [default: 12:20:28 INFO - "/builds/slave/test"] 12:20:28 INFO - --app=APP Application being installed. [default: firefox] 12:20:28 INFO - mkdir: /builds/slave/test/build/application 12:20:28 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'] 12:20:28 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 12:20:44 INFO - Reading from file tmpfile_stdout 12:20:44 INFO - Output received: 12:20:44 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:44 INFO - Running post-action listener: _resource_record_post_action 12:20:44 INFO - ##### 12:20:44 INFO - ##### Running run-tests step. 12:20:44 INFO - ##### 12:20:44 INFO - Running pre-action listener: _resource_record_pre_action 12:20:44 INFO - Running main action method: run_tests 12:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:44 INFO - Python 2.7.3 12:20:44 INFO - Return code: 0 12:20:44 INFO - grabbing minidump binary from tooltool 12:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:44 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 0x1afa410>, '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 0x1afb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:44 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 12:20:44 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 12:20:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:44 INFO - Return code: 0 12:20:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:20:45 INFO - Return code: 0 12:20:45 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/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:20:45 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/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 12:20:45 INFO - Using env: {'DISPLAY': ':0', 12:20:45 INFO - 'HOME': '/home/cltbld', 12:20:45 INFO - 'LANG': 'en_US.UTF-8', 12:20:45 INFO - 'LANGUAGE': 'en_US:en', 12:20:45 INFO - 'LOGNAME': 'cltbld', 12:20:45 INFO - 'MAIL': '/var/mail/cltbld', 12:20:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:45 INFO - 'MOZ_NO_REMOTE': '1', 12:20:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:45 INFO - 'NO_EM_RESTART': '1', 12:20:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:45 INFO - 'PWD': '/builds/slave/test', 12:20:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:45 INFO - 'SHELL': '/bin/bash', 12:20:45 INFO - 'SHLVL': '1', 12:20:45 INFO - 'TERM': 'linux', 12:20:45 INFO - 'TMOUT': '86400', 12:20:45 INFO - 'USER': 'cltbld', 12:20:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573', 12:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:45 INFO - '_': '/tools/buildbot/bin/python'} 12:20:45 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/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:20:45 INFO - mozversion application_buildid: 20160425113506 12:20:45 INFO - mozversion application_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 12:20:45 INFO - mozversion application_display_name: Nightly 12:20:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:45 INFO - mozversion application_name: Firefox 12:20:45 INFO - mozversion application_remotingname: firefox 12:20:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:20:45 INFO - mozversion application_vendor: Mozilla 12:20:45 INFO - mozversion application_version: 48.0a1 12:20:45 INFO - mozversion platform_buildid: 20160425113506 12:20:45 INFO - mozversion platform_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 12:20:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:20:45 INFO - mozversion platform_version: 48.0a1 12:20:45 INFO - using testdate: 1461612045 12:20:45 INFO - actual date: 1461612045 12:20:45 INFO - starting webserver on 'localhost:41599' 12:20:45 INFO - SUITE-START | Running 2 tests 12:20:45 INFO - TEST-START | dromaeo_css 12:20:45 INFO - operating with platform_type : linux_ 12:20:45 INFO - Initialising browser for dromaeo_css test... 12:20:45 INFO - TEST-INFO | started process 7728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGUlqn/profile http://localhost:41599/getInfo.html) 12:20:50 INFO - PROCESS | 7728 | __metrics Screen width/height:1600/1200 12:20:50 INFO - PROCESS | 7728 | colorDepth:24 12:20:50 INFO - PROCESS | 7728 | Browser inner width/height: 1024/697 12:20:50 INFO - PROCESS | 7728 | __metrics 12:20:51 ERROR - PROCESS | 7728 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:20:51 INFO - TEST-INFO | 7728: exit 0 12:20:51 INFO - Browser initialized. 12:20:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:51 INFO - TEST-INFO | started process 7809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGUlqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:04 INFO - PROCESS | 7809 | RSS: Main: 155992064 12:21:04 INFO - PROCESS | 7809 | 12:21:55 INFO - PROCESS | 7809 | 1461612115443 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] 12:24:06 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41599/tests/dromaeo/cssquery-ext.html) 12:24:08 INFO - PROCESS | 7809 | RSS: Main: 275341312 12:24:08 INFO - PROCESS | 7809 | 12:27:10 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-ext.html (next: http://localhost:41599/tests/dromaeo/cssquery-jquery.html) 12:27:11 INFO - PROCESS | 7809 | RSS: Main: 242778112 12:27:11 INFO - PROCESS | 7809 | 12:30:13 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41599/tests/dromaeo/cssquery-mootools.html) 12:30:13 INFO - PROCESS | 7809 | RSS: Main: 238153728 12:30:13 INFO - PROCESS | 7809 | 12:33:16 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41599/tests/dromaeo/cssquery-prototype.html) 12:33:16 INFO - PROCESS | 7809 | RSS: Main: 233545728 12:33:16 INFO - PROCESS | 7809 | 12:36:19 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41599/tests/dromaeo/cssquery-yui.html) 12:36:20 INFO - PROCESS | 7809 | RSS: Main: 210276352 12:36:20 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | Cycle 1(1): loaded http://localhost:41599/tests/dromaeo/cssquery-yui.html (next: http://localhost:41599/tests/dromaeo/cssquery-dojo.html) 12:39:23 INFO - PROCESS | 7809 | RSS: Main: 253591552 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | __start_tp_report 12:39:23 INFO - PROCESS | 7809 | _x_x_mozilla_page_load 12:39:23 INFO - PROCESS | 7809 | _x_x_mozilla_page_load_details 12:39:23 INFO - PROCESS | 7809 | |i|pagename|runs| 12:39:23 INFO - PROCESS | 7809 | |0;dojo.html;2620.947581048379;2651.4829608226405;2707.729227077292;2716.1036857836916;2736.9178924632256;4613.769311534426;4674.579287864091;4716.55192756688;4726.078414709129;4773.761311934402;4668.159731248374;4728.692634978724;4748.5726284634375;4750.049990001996;4750.358701575286;4216.536181020086;4258.872233832983;4274.487061552618;4302.182585308797;4446.021875187454;4378.233809083414;4400.427944367228;4403.471583409995;4448.510663826976;4453.799579018936;4298.26929421999;4309.310510318334;4361.956380436202;4365.257906155961;4396.340548917656;4321.567843215685;4352.956470435319;4362.236608593484;4365.716228445141;4402;4314.870553883388;4319.157764235975;4331.675124365685;4336.588024137702;4384.12317536494;4422.778861056967;4548.772561371951;4590.74750888701;4637.582617564435;4669.369635099252;5069.746512674388;5088.211327244283;5089.770960306795;5097.082525145473;5122.257272695476;5090.287359769598;5097.9490205097845;5101.642884998052;5108.770105345268;5119.718415487147;4642.210824159867;4736.763161841963;4751.168545504523;4823.734694591761;4830.468648448667;5243.685378877203;5251.0548101341365;5258.1849813279005;5269.1569348903995;5276.947230527722;5024.497550244946;5029.874253143627;5030.270610761419;5034.647574669812;5071.163258062378;4960.355153829979;5037.244413338029;5072.644914855925;5121.590272778169;5125.410577783603;4970.527799859007;5022.7990880365105;5024.874378140503;5027.748612569357;5076.2131869559535;4832.903341933142;4991.600671946236;5004.774785134678;5009.223570346602;5016.297718319438;4229.175310814362;4267.146570685875;4330.242207613655;4341.110072435144;4341.804618792162;3716.1267102230954;3753.49327840738;3763.849446022183;3794.354959656865;3799.0122568131933;4422.115576884636;4447.399601053881;4450.666200034945;4451.7996690148375;4495.1234509271035;4900.754962251873;5037.571806396498;5050.343455350854;5076.796928122908;5078.898422031539;4342.82628694855;4366.083122544238;4432.29083346663;4433.667474939392;4470.888227794266;4498.820047198141;4582.518835522222;4583.679142459996;4583.977080114645;4617.976910115495;4725.763711814464;4756.23900175984;4768.976155119202;4813.566778989908;4815.590674792542;5037.697738135724;5076.36545431821;5089.465606111453;5108.974455127701;5118.948810511847;4695.154872122914;4767.952320476751;4788.970371370172;4811.350467686958;4851.587615052619;5002.724850133278;5029.874253143555;5032.773525191448;5034.798608055637;5064.873378165576;5089.745512724423;5096.23556466533;5099.158638824552;5110.8466745997675;5117.718525480986;4817.421909370758;4943.752812359439;4950.9257361140335;4954.232094025288;5032.748362581783;4955.083309587738;4976.029674213493;4977.875553111201;4984.775685094107;4999.77501012448;4882.316475693477;4900.705957642553;4904.166291730343;4905.975470122627;4935.75321233944;4816.518348165156;4844.46710861812;4973.079980203674;5028.270900719302;5040.36995375578;4698.154332220233;4755.453122890912;4758.405199350082;4759.024399998061;4880.780364883518 12:39:23 INFO - PROCESS | 7809 | |1;ext.html;553.4982666246453;587.7384563869078;596.064179238595;605.4671888737911;607.8571535689115;26397.07610233642;34301.82849085757;34517.30965380694;34968.65031349686;35249.295014099735;36995.445068324;37490.25019499615;37566.24867502655;37685.24629507408;37763.811180944125;7207.639618019104;7615.466917315804;7830.216978302181;7832.255935686101;7834.647440865175;9817.901820981806;9851;9859.063388978071;9859.654912078078;9900.90099099007;9859.211263098934;10017.19862411009;10029.297949143564;10029.498525073754;10030.247731420137;9702.805943881118;9844.474106513502;9853.162481189107;9855.162311203556;9862.260330475172;9729.075737804897;9889.456079915602;9904;10138.935411781731;10183.236257280734;26014.479710405685;26730.331741706614;26745;26760.253564500985;38329.42505862414;2788.4980703473366;2829.9292517687018;2841;2857.1857020749194;2907.7092290770966;27338.589921151197;27393.726062739315;27429.588556171675;27693.723062769317;27758.722412776016;3348.414027545194;3403.1322012886803;3407.47184186449;3408.3183363327435;3485.75599708018;173695;177032.99999999872;177305;178102;178288;55138.72430637821;56348.71825640927;56365.15452268219;56390;56400.43599563952;59520.70239648774;59690;59758.103628445606;59797.701011495534;59930.700346497986;14511.927440362731;15047.548573542812;15051.623709407353;15053.473128440672;15054.548363549111;10228.64199753005;10485.737856553647;10497.370157790558;10498.947505262577;11170.329780213051;17455.73816392755;17870.731939020927;17958.820411795714;18022.64573318827;18106.547336316697;6901.896471552931;6928.515003949675;7263.709451621876;7316.743913962986;7351.705931762776;767.8924950506934;832.7876391520124;893.8748575199477;961.8845738511284;1024.6977141743055;26949.595756063674;28109.859450703025;28115.71884281131;28537.71462285392;28720;946.9857952130724;976.4190306767462;1026.8819085805078;1049.5539395756773;1077.5258886090253;14690.11859288446;15164.469243576423;15263.313150908014;15359.385624574892;15504.767428488582;317105;320265;320898;323202;323225;50086;51050.23424648633;51074;51097;51145.48854511407;1088.8530048443517;1203.5907791350808;1216.2823933878876;1220.9865811376715;1308.032056278366;24294.78526073654;25344.239672809847;26040.218793436226;26318.736812632396;26370.73629263683;36166.457503138;36455.27089458249;36753.816230918674;36762.448563271035;36816.44775328426;180729;181561;181977;182485;182957;28183;32612.184695382806;33045.83477082599;33163.35203127606;33373.83313083419;38183;40362;40503.59496404998;40722.1855562893;41299.58700412957;33827.492587610715;34648.30703385868;34898.47652285167;35186.824065879504;35251.64748352484;34461;34709.47935780915;34776.30447391089;34790.13024674403;35273.823630881685;33792.324153517286;34597.48103778395;34616;34886.82556587201;34912.825435872655;30191;30779.384412312076;30790.846045769627;30826;30961.380772383975;23939.88030059908;24145.879270603535;24272;24611.261662150166;24620.87689561541 12:39:23 INFO - PROCESS | 7809 | |2;jquery.html;379.0864017717301;389.1963096206334;392.51916402407056;396.68317876763115;399.53454225826914;16152.273147708353;16535.66928661429;16642.334306627734;16663.41678041269;16703.08133052683;16050.518484445485;16451;16873.83126168738;16975.57561060974;17361.91319043406;5010.498950104997;5179.585633149339;5202.973985130088;5221.895562088756;5222.268882356473;5103.106956282654;5128.769205385748;5193.480651934814;5195.142801437758;5198.818041368553;5008.924866127011;5114.232865070232;5129.512696293846;5135.024345374367;5136.178211486163;5056.266841308008;5095.3376061112;5135.717535535544;5137.768800403972;5140.3060586820675;4450.132224216279;4571.542845715435;4610.746408947506;4620.6303495720595;4625.398698169217;10582.841257381146;20504.43694538183;21337.466563335885;21359.466013349636;21375.358739237847;1797.973030404545;1810.97283540747;1819.3359423810346;1821.9362322318655;2166.729158855143;8982.461052336881;8991.100889911022;9075.18323350895;9166.908330916738;9410.670626528106;1744.5725797179646;1849.7225416187546;1854.1563588567305;1865.813418658137;1933.1494142577221;68821;71586.284137159;71878;72266;72320.2767972324;9974.850377244347;10048.849267260997;10162.644307449204;10192;10393.53229104692;14042.719145617235;14158.292085395895;14172.362243699059;14186.503472378417;14204.147751134966;7384.1877393486675;7385.29839665231;7469.178390377054;7486.4759466836795;7635.69457221716;7259.603913147245;7272.094295518931;7335.596542190124;7421.962890185515;7441.776746697607;4265.978670106691;4314.590113939171;4349.956500435019;4438.556144385536;4446.288593824973;1816.9454916352531;1826.5159732670852;1845.8431033362315;1845.898475583829;1920.5870737791442;845.6617353058703;877.9385443019055;888.9733308000771;900.3607438718452;907.945523268606;15707;16005.67988640244;16296.42962496307;16482.75275870863;16664;851.3274513134678;855.5294587976588;859.0679113162164;891.9875940807101;914.0695011450736;9180.265578753684;9520.047995200424;9566.808663826685;9659.372140810825;9671.32939899806;273687;278423;279059;282687;332348;75338.62330688421;77963.61018194872;78398.6080069596;85149;86077;947.062408215875;948.1229862377273;973.7176218896583;978.882534095913;982.9066238707311;15438.45965391206;15722.05667659944;15736.29186686579;15787.447439339569;16074.919625401799;36065.27869442649;36257;36867;37413.25173496569;37491.250174996894;50337.49662503328;51766.223506646675;51820;51849.740751296005;52271.47728522666;7315.707371705073;7354.742584009534;7471.290227428385;7505.962470187833;7680.769576912701;10809.67570972872;11532.654020379403;11724.824127637921;11781.882181178078;11800.910754988994;9756.365836220622;10255.94872025635;10392.948035259775;10522.158227341948;10607.787844243227;9638.759031024;9683.951580242054;10240.18078553699;10328.431936243578;10380;5210.53105220532;7778.533288002738;9082.59128339213;10370.533326000197;10370.688879333633;7519.473636845369;7573;7582.734604288823;7747.612619369122;7924.6830126796585;7694.461387702807;8823.338249631432;9378.437293762396;10055.597776089167;10450.68647940563 12:39:23 INFO - PROCESS | 7809 | |3;mootools.html;1228.1341654133837;1449.521657852909;1465.1941432212282;1580.6048487878031;1763.929442822288;7243.384312333452;7599.316061554459;7602.125755538108;7602.163761986177;7608.809779755509;7354.080739907512;7531.397488200944;7533.982912306837;7535.698572057111;7540.622968851563;1888.726134710466;1956.158851693771;1961.2743284984504;2199.7910198531113;2240.2943072932057;2179.3679832848456;2234.307364716943;2234.977650223493;2237.697910782048;2240.5854916840353;2129.127057906259;2142.1217300906633;2153.881536515491;2156.91372345106;2175.7824217578273;1890.3383815664545;2160.6326924422888;2171.1206961180746;2181.4110190248543;2182.050807898569;2183.8034576888;2188.234118058667;2209.7127373441513;2215.6122678531356;2215.678726584636;7180.640967951582;7251;7259.963700181518;7261.2012678605315;7263.201047884729;4384.671149663756;4542.250528662767;4547.8635640930825;4570.314452832068;4572.314152877095;2762.861856907167;2815.8310501369983;2926.4293462774767;2943.2200466876293;2950.3361743607516;873.76845136039;880.9075047120024;883.2889523933231;883.6200433813458;885.5572213893054;10175.338602990782;10422.583096676048;10425.374477531297;10448.477576121164;10457.267991240617;4243.42713733642;4276.550962148992;4404.55954404557;4451.265541185733;4454.7549884756;8987.685431010013;9060.501672408082;9068.138526839939;9087.454752714859;9093.181613654802;4759.690620109682;4781.593564546983;4792.472827988919;4796.160671882407;4799.832005879777;3689.870854520079;4165.416841642173;4313.633341166036;4318.114786468766;4326.329418940069;3659.4876717259604;3664.2305115925956;3748.55017397914;3767.05823544114;3795.3927371620407;1204.8614409342863;1214.5445457953267;1239.863615002349;1252.6993521554944;1253.4547471849774;711.5375006245878;728.388153950684;734.4271468254769;749.7001199520236;757.5189754505928;4718.31584420264;4782.52174782519;4811.78346974387;4815.398075240595;4997.075541024922;404.1613651672732;421.1913126796558;424.8959005043784;426.0180284444385;427.8010725012884;3232.935341293208;3282.885099021523;3318.5851768528933;3330.9333813323597;3373.7132343750563;8988.191062804248;9402.730631364679;9546.236301095896;9557.761055973517;9586.95206523963;8405;8717.52053637056;8736.25741811953;8861.73414797557;9457.33798634089;6821.420179284816;6915.965420172967;6916.515843890879;6962.756303529352;6973;5249.47505249472;5319.095753721799;5399.487048730364;5473.179023146401;5478.178273259043;8512.70205542803;8924.821503570021;8969.058248883774;9029.458232506071;9045.592948317473;8807.928531546693;8842.557872106498;8876.911230887608;8925.910740892508;9105.135012173832;6017.969910150421;6187.412195841388;6191.876162476815;6714.093597364294;6869.7595584154315;5731.541476681772;6499.935000650122;6870.690818913061;6916.23921368639;6918.792436226921;6216.067589861557;6243.531735119794;6316;6336.58812177207;6383.840403989938;6070.878582428415;6098.786542470993;6103.023516237381;6120.326764056039;6222.439980401786;5521.503064724194;5603.159526071122;5655.604107712421;5848.064309710426;5858.94141058584;4218.43051188098;4359.760213188305;4395.8021889014435;4455.777211139365;4495.640348772155;4315.708201539214;4336.1978034063795;4377.518472967908;4425.446819147606;4448 12:39:23 INFO - PROCESS | 7809 | |4;prototype.html;310.1610144558968;311.1226341716361;312.9514925186594;314.292841107508;314.49837509172863;4734.360861283726;4804.951950480498;4812.9518704812945;4815.494373090827;4823.324734537163;4650.3024546318065;4705.388299521066;4708.482066972639;4724.48816378759;4733.171694953387;3544.751867369279;3573.94639080414;3645.143391303042;3750.474933509311;3753.3244016077097;3632.4551317302353;3726.8260497943197;3736.9252614947686;3740.7007439404783;3743.51056547397;3688.391415416453;3706.2587482503473;3722.367197576405;3727.6458736419995;3737.2338670572467;3519.0293435675976;3593.7843729376323;3722.925541489155;3737.4206997915367;3756.8309426075893;3326.9500957485657;3331.1339051846453;3332.950005749916;3340.699337059652;3351.4302568563403;4506.031203291275;4536.296873984537;4538.160440318518;4555.111753208126;4568.1548913451115;3983.880483585497;4190.643795277405;4245.490541135053;4260.786960651955;4278.550752171009;4934.5312195341385;4936.259561065869;4948.752562371903;4950.43070046942;4950.43070046942;3532.947005794915;3549.8225088745717;3551.8401671924826;3579.266250418658;3587.282543491286;5059.1905295152965;5179.482051794828;5212.765425555821;5236.6857988520815;5264.973675131638;3628.4920111184456;3630.2920930418313;3641.1443310821937;3657.195417008254;3661.1213308806227;3668.248009158116;3668.63313668631;3694.983879433177;3701.2782507411334;3710.8144592770795;4179.97910010448;4189.895252618709;4206.642435392964;4212.936805947913;4219.261629214875;4872.171730805771;4976.377952755905;5000.474950130257;5015.774290156952;5023.919857230713;1337.8026666133755;1344.7108871592654;1345.9434344039882;1352.7159296547638;1355.3494322725146;855.9101294364127;879.3404946290283;900.0324651000201;923.2429407885469;927.1794461901266;4354.542773008852;4456.665750068758;4626.375439315717;4626.606738427204;4630.745309008037;5123.487651234846;5165.502004418751;5180.404253510895;5182.585393168538;5189.558887494605;4304.246756817544;4471.485779135376;4494.325851122358;4499.437570303712;4511.481179664315;2882.962133631891;2888.566714992768;2889.7688184945155;2911.315840777416;2915.25660956459;5138.152204886152;5140.537351638371;5164.354455693038;5166.509181627739;5168.715720635401;5392.946070539323;5573.303337082864;5573.944260557342;5595.972020139955;5609.4390560943575;5107.846764596994;5112.539871411591;5126.666766660155;5141.401019286514;5151.7681704323395;5423;5440.470181365684;5471;5484.149956756709;5491.341039075177;5145.511176438233;5320.201969704421;5338.733063346895;5352.734831752706;5376.139817629317;5120.564751995973;5125.641205115606;5145.742712864417;5152.381714194321;5170.922436163385;3917.451556781996;3949.881503554898;3951.6838652908273;3963.3262345400776;3963.553303044426;5264.921026184534;5413.40452550227;5417.133258678593;5440.782368705208;5444.292242008513;5196.922046169235;5231.529162375405;5236.214567814858;5239.764210610456;5243.423223445494;5216.035033518811;5229.92155117666;5240.68555886648;5245.344331958505;5247.396549396715;5018.447970723145;5141.100307446257;5147.948520514747;5175.948240517697;5196.68819870809;4714.811407543797;4831.347768051268;4944.381952255968;4991.376077990251;4997.900041999213;4890.755462226945;4921.901561968669;4924.236743304794;4929.693631187666;4948.208286674115 12:39:23 INFO - PROCESS | 7809 | |5;yui.html;630.3161070238791;640.1773720768813;655.9832259997004;690.6408667492904;745.6309126982145;11986.400679966011;12015.819762703555;12202.206856554329;12255.509779608827;12291.139620226566;11927.940360298186;11943.940280298586;11963;11977.401129943511;11987.580434684787;635.920509936258;775.3642013548892;790.044046703488;803.7508372404544;806.7821688144197;794.1740589786643;800.8438354520871;802.1256830055239;802.2699343597328;803.3773825285422;836.477201748907;837.401258100458;838.5010918503481;838.6226198210799;838.6310023589632;660.7819419591523;822.7490615362312;835;845.5518575155178;846.5597889097696;618.6411881108946;619.6777675608703;619.7582942652369;620.3610281410155;620.9844753881144;11504.482298296596;11604.76790464186;11691.356975366352;11694.824577631342;11759.588414405454;11947.223430476992;12184.695382615506;12264.816027759502;12272.32502212378;12308.630741077692;10030.9498452508;10060.144887684555;10109.646162384355;10143.695689129338;10269.486525673761;3251.902442926716;3309.619393769699;3320.833958302075;3325.7505687073326;3351.8324083795715;43446.348304775456;43497;43621;45026.77486612579;45281.320780188325;9785.755356116011;9830.557624906896;9982.850257246148;9990.80018399628;10040;16533.256003479873;16955.067471289196;16957.915210423867;16970;17024.91487542579;6373.235211774524;6428.067930150196;6474.1907261592305;6550.475961923034;6733;3449.862005519801;3464.566929133858;3486.1110416843544;3515.226650136966;3540.097275194809;2795.398989217328;2842.019503271368;2847.18855126288;2849.6437945256844;2856.3287627407544;500.96994180348565;506.5668853130594;517.1751057063977;521.4889408379809;522.5975998481148;570.589175793428;606.2119244981507;606.2388760650318;606.9484093852072;610.9480694141048;7156.92843071573;7349.375303099189;7446;7549.131849837229;7647.502912310682;586.8972929737279;599.1462166412845;606.1029676079427;615.2647586134616;626.4737620398887;2928.194746444702;3035.2867076237067;3047.1620304416465;3061.540768884685;3070.831104289241;53780;55605.165922511194;56026;57359.426405736245;57470;45486.772566136955;46917.061658767314;47678.5232147681;48011.27983080257;48977.26534101991;45139.54860451353;45427.54572454299;45528.54471455309;45930.54069459329;46214;7033.120859892513;7088.930140892883;7133.215346312006;7151.749688760869;7218.458615603746;28599.42801144007;29211.561826572193;29511;29801.10596682103;29868.402631946803;35947.28105437929;37080.25839483249;39941.40087898742;40028.399574006995;40694;9637.566309516229;9702.563384647567;9807.607695692377;9879.703608891745;9974.55114519863;11099.72250693739;11146.944265278622;11153.776924461628;11375.886241137483;11786.587469438871;10419.270651054354;10642.73393165177;10736.73158171052;10865.293755905841;11003.504842281956;10760.085392741392;10826.837597436202;11224.270422422516;11289.435528223721;11337.09303255721;9924.454155021544;10244.538995745359;10419.791604167722;10586.8411973822;10720.088792452729;9134.451932884049;9505.144536991704;9517.714468565953;9718.986495587358;9765.755856103655;8835.867461988204;9090.409123406956;9245.537723113683;9297.116773906468;9327.191319110167 12:39:23 INFO - PROCESS | 7809 | __end_tp_report 12:39:23 INFO - PROCESS | 7809 | __start_cc_report 12:39:23 INFO - PROCESS | 7809 | _x_x_mozilla_cycle_collect,1144 12:39:23 INFO - PROCESS | 7809 | __end_cc_report 12:39:23 INFO - PROCESS | 7809 | __startTimestamp1461613163375__endTimestamp 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | ------- Summary: start ------- 12:39:23 INFO - PROCESS | 7809 | Number of tests: 6 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#0] dojo.html Cycles:165 Average:4685.17 Median:4788.97 stddev:487.15 (10.2%) stddev-sans-first:460.95 12:39:23 INFO - PROCESS | 7809 | Values: 2620.9 2651.5 2707.7 2716.1 2736.9 4613.8 4674.6 4716.6 4726.1 4773.8 4668.2 4728.7 4748.6 4750.0 4750.4 4216.5 4258.9 4274.5 4302.2 4446.0 4378.2 4400.4 4403.5 4448.5 4453.8 4298.3 4309.3 4362.0 4365.3 4396.3 4321.6 4353.0 4362.2 4365.7 4402.0 4314.9 4319.2 4331.7 4336.6 4384.1 4422.8 4548.8 4590.7 4637.6 4669.4 5069.7 5088.2 5089.8 5097.1 5122.3 5090.3 5097.9 5101.6 5108.8 5119.7 4642.2 4736.8 4751.2 4823.7 4830.5 5243.7 5251.1 5258.2 5269.2 5276.9 5024.5 5029.9 5030.3 5034.6 5071.2 4960.4 5037.2 5072.6 5121.6 5125.4 4970.5 5022.8 5024.9 5027.7 5076.2 4832.9 4991.6 5004.8 5009.2 5016.3 4229.2 4267.1 4330.2 4341.1 4341.8 3716.1 3753.5 3763.8 3794.4 3799.0 4422.1 4447.4 4450.7 4451.8 4495.1 4900.8 5037.6 5050.3 5076.8 5078.9 4342.8 4366.1 4432.3 4433.7 4470.9 4498.8 4582.5 4583.7 4584.0 4618.0 4725.8 4756.2 4769.0 4813.6 4815.6 5037.7 5076.4 5089.5 5109.0 5118.9 4695.2 4768.0 4789.0 4811.4 4851.6 5002.7 5029.9 5032.8 5034.8 5064.9 5089.7 5096.2 5099.2 5110.8 5117.7 4817.4 4943.8 4950.9 4954.2 5032.7 4955.1 4976.0 4977.9 4984.8 4999.8 4882.3 4900.7 4904.2 4906.0 4935.8 4816.5 4844.5 4973.1 5028.3 5040.4 4698.2 4755.5 4758.4 4759.0 4880.8 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#1] ext.html Cycles:180 Average:39399.12 Median:18570.37 stddev:61851.60 (333.1%) stddev-sans-first:61956.34 12:39:23 INFO - PROCESS | 7809 | Values: 553.5 587.7 596.1 605.5 607.9 26397.1 34301.8 34517.3 34968.7 35249.3 36995.4 37490.3 37566.2 37685.2 37763.8 7207.6 7615.5 7830.2 7832.3 7834.6 9817.9 9851.0 9859.1 9859.7 9900.9 9859.2 10017.2 10029.3 10029.5 10030.2 9702.8 9844.5 9853.2 9855.2 9862.3 9729.1 9889.5 9904.0 10138.9 10183.2 26014.5 26730.3 26745.0 26760.3 38329.4 2788.5 2829.9 2841.0 2857.2 2907.7 27338.6 27393.7 27429.6 27693.7 27758.7 3348.4 3403.1 3407.5 3408.3 3485.8 173695.0 177033.0 177305.0 178102.0 178288.0 55138.7 56348.7 56365.2 56390.0 56400.4 59520.7 59690.0 59758.1 59797.7 59930.7 14511.9 15047.5 15051.6 15053.5 15054.5 10228.6 10485.7 10497.4 10498.9 11170.3 17455.7 17870.7 17958.8 18022.6 18106.5 6901.9 6928.5 7263.7 7316.7 7351.7 767.9 832.8 893.9 961.9 1024.7 26949.6 28109.9 28115.7 28537.7 28720.0 947.0 976.4 1026.9 1049.6 1077.5 14690.1 15164.5 15263.3 15359.4 15504.8 317105.0 320265.0 320898.0 323202.0 323225.0 50086.0 51050.2 51074.0 51097.0 51145.5 1088.9 1203.6 1216.3 1221.0 1308.0 24294.8 25344.2 26040.2 26318.7 26370.7 36166.5 36455.3 36753.8 36762.4 36816.4 180729.0 181561.0 181977.0 182485.0 182957.0 28183.0 32612.2 33045.8 33163.4 33373.8 38183.0 40362.0 40503.6 40722.2 41299.6 33827.5 34648.3 34898.5 35186.8 35251.6 34461.0 34709.5 34776.3 34790.1 35273.8 33792.3 34597.5 34616.0 34886.8 34912.8 30191.0 30779.4 30790.8 30826.0 30961.4 23939.9 24145.9 24272.0 24611.3 24620.9 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#2] jquery.html Cycles:180 Average:21520.92 Median:5009.71 stddev:48983.71 (977.8%) stddev-sans-first:49095.40 12:39:23 INFO - PROCESS | 7809 | Values: 379.1 389.2 392.5 396.7 399.5 16152.3 16535.7 16642.3 16663.4 16703.1 16050.5 16451.0 16873.8 16975.6 17361.9 5010.5 5179.6 5203.0 5221.9 5222.3 5103.1 5128.8 5193.5 5195.1 5198.8 5008.9 5114.2 5129.5 5135.0 5136.2 5056.3 5095.3 5135.7 5137.8 5140.3 4450.1 4571.5 4610.7 4620.6 4625.4 10582.8 20504.4 21337.5 21359.5 21375.4 1798.0 1811.0 1819.3 1821.9 2166.7 8982.5 8991.1 9075.2 9166.9 9410.7 1744.6 1849.7 1854.2 1865.8 1933.1 68821.0 71586.3 71878.0 72266.0 72320.3 9974.9 10048.8 10162.6 10192.0 10393.5 14042.7 14158.3 14172.4 14186.5 14204.1 7384.2 7385.3 7469.2 7486.5 7635.7 7259.6 7272.1 7335.6 7422.0 7441.8 4266.0 4314.6 4350.0 4438.6 4446.3 1816.9 1826.5 1845.8 1845.9 1920.6 845.7 877.9 889.0 900.4 907.9 15707.0 16005.7 16296.4 16482.8 16664.0 851.3 855.5 859.1 892.0 914.1 9180.3 9520.0 9566.8 9659.4 9671.3 273687.0 278423.0 279059.0 282687.0 332348.0 75338.6 77963.6 78398.6 85149.0 86077.0 947.1 948.1 973.7 978.9 982.9 15438.5 15722.1 15736.3 15787.4 16074.9 36065.3 36257.0 36867.0 37413.3 37491.3 50337.5 51766.2 51820.0 51849.7 52271.5 7315.7 7354.7 7471.3 7506.0 7680.8 10809.7 11532.7 11724.8 11781.9 11800.9 9756.4 10255.9 10392.9 10522.2 10607.8 9638.8 9684.0 10240.2 10328.4 10380.0 5210.5 7778.5 9082.6 10370.5 10370.7 7519.5 7573.0 7582.7 7747.6 7924.7 7694.5 8823.3 9378.4 10055.6 10450.7 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#3] mootools.html Cycles:180 Average:4945.62 Median:4798.00 stddev:2769.78 (57.7%) stddev-sans-first:2763.46 12:39:23 INFO - PROCESS | 7809 | Values: 1228.1 1449.5 1465.2 1580.6 1763.9 7243.4 7599.3 7602.1 7602.2 7608.8 7354.1 7531.4 7534.0 7535.7 7540.6 1888.7 1956.2 1961.3 2199.8 2240.3 2179.4 2234.3 2235.0 2237.7 2240.6 2129.1 2142.1 2153.9 2156.9 2175.8 1890.3 2160.6 2171.1 2181.4 2182.1 2183.8 2188.2 2209.7 2215.6 2215.7 7180.6 7251.0 7260.0 7261.2 7263.2 4384.7 4542.3 4547.9 4570.3 4572.3 2762.9 2815.8 2926.4 2943.2 2950.3 873.8 880.9 883.3 883.6 885.6 10175.3 10422.6 10425.4 10448.5 10457.3 4243.4 4276.6 4404.6 4451.3 4454.8 8987.7 9060.5 9068.1 9087.5 9093.2 4759.7 4781.6 4792.5 4796.2 4799.8 3689.9 4165.4 4313.6 4318.1 4326.3 3659.5 3664.2 3748.6 3767.1 3795.4 1204.9 1214.5 1239.9 1252.7 1253.5 711.5 728.4 734.4 749.7 757.5 4718.3 4782.5 4811.8 4815.4 4997.1 404.2 421.2 424.9 426.0 427.8 3232.9 3282.9 3318.6 3330.9 3373.7 8988.2 9402.7 9546.2 9557.8 9587.0 8405.0 8717.5 8736.3 8861.7 9457.3 6821.4 6916.0 6916.5 6962.8 6973.0 5249.5 5319.1 5399.5 5473.2 5478.2 8512.7 8924.8 8969.1 9029.5 9045.6 8807.9 8842.6 8876.9 8925.9 9105.1 6018.0 6187.4 6191.9 6714.1 6869.8 5731.5 6499.9 6870.7 6916.2 6918.8 6216.1 6243.5 6316.0 6336.6 6383.8 6070.9 6098.8 6103.0 6120.3 6222.4 5521.5 5603.2 5655.6 5848.1 5858.9 4218.4 4359.8 4395.8 4455.8 4495.6 4315.7 4336.2 4377.5 4425.4 4448.0 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#4] prototype.html Cycles:180 Average:4240.53 Median:4733.77 stddev:1244.75 (26.3%) stddev-sans-first:1212.78 12:39:23 INFO - PROCESS | 7809 | Values: 310.2 311.1 313.0 314.3 314.5 4734.4 4805.0 4813.0 4815.5 4823.3 4650.3 4705.4 4708.5 4724.5 4733.2 3544.8 3573.9 3645.1 3750.5 3753.3 3632.5 3726.8 3736.9 3740.7 3743.5 3688.4 3706.3 3722.4 3727.6 3737.2 3519.0 3593.8 3722.9 3737.4 3756.8 3327.0 3331.1 3333.0 3340.7 3351.4 4506.0 4536.3 4538.2 4555.1 4568.2 3983.9 4190.6 4245.5 4260.8 4278.6 4934.5 4936.3 4948.8 4950.4 4950.4 3532.9 3549.8 3551.8 3579.3 3587.3 5059.2 5179.5 5212.8 5236.7 5265.0 3628.5 3630.3 3641.1 3657.2 3661.1 3668.2 3668.6 3695.0 3701.3 3710.8 4180.0 4189.9 4206.6 4212.9 4219.3 4872.2 4976.4 5000.5 5015.8 5023.9 1337.8 1344.7 1345.9 1352.7 1355.3 855.9 879.3 900.0 923.2 927.2 4354.5 4456.7 4626.4 4626.6 4630.7 5123.5 5165.5 5180.4 5182.6 5189.6 4304.2 4471.5 4494.3 4499.4 4511.5 2883.0 2888.6 2889.8 2911.3 2915.3 5138.2 5140.5 5164.4 5166.5 5168.7 5392.9 5573.3 5573.9 5596.0 5609.4 5107.8 5112.5 5126.7 5141.4 5151.8 5423.0 5440.5 5471.0 5484.1 5491.3 5145.5 5320.2 5338.7 5352.7 5376.1 5120.6 5125.6 5145.7 5152.4 5170.9 3917.5 3949.9 3951.7 3963.3 3963.6 5264.9 5413.4 5417.1 5440.8 5444.3 5196.9 5231.5 5236.2 5239.8 5243.4 5216.0 5229.9 5240.7 5245.3 5247.4 5018.4 5141.1 5147.9 5175.9 5196.7 4714.8 4831.3 4944.4 4991.4 4997.9 4890.8 4921.9 4924.2 4929.7 4948.2 12:39:23 INFO - PROCESS | 7809 | 12:39:23 INFO - PROCESS | 7809 | [#5] yui.html Cycles:180 Average:12729.68 Median:46565.53 stddev:14914.26 (32.0%) stddev-sans-first:14928.42 12:39:23 INFO - PROCESS | 7809 | Values: 630.3 640.2 656.0 690.6 745.6 11986.4 12015.8 12202.2 12255.5 12291.1 11927.9 11943.9 11963.0 11977.4 11987.6 635.9 775.4 790.0 803.8 806.8 794.2 800.8 802.1 802.3 803.4 836.5 837.4 838.5 838.6 838.6 660.8 822.7 835.0 845.6 846.6 618.6 619.7 619.8 620.4 621.0 11504.5 11604.8 11691.4 11694.8 11759.6 11947.2 12184.7 12264.8 12272.3 12308.6 10030.9 10060.1 10109.6 10143.7 10269.5 3251.9 3309.6 3320.8 3325.8 3351.8 43446.3 43497.0 43621.0 45026.8 45281.3 9785.8 9830.6 9982.9 9990.8 10040.0 16533.3 16955.1 16957.9 16970.0 17024.9 6373.2 6428.1 6474.2 6550.5 6733.0 3449.9 3464.6 3486.1 3515.2 3540.1 2795.4 2842.0 2847.2 2849.6 2856.3 501.0 506.6 517.2 521.5 522.6 570.6 606.2 606.2 606.9 610.9 7156.9 7349.4 7446.0 7549.1 7647.5 586.9 599.1 606.1 615.3 626.5 2928.2 3035.3 3047.2 3061.5 3070.8 53780.0 55605.2 56026.0 57359.4 57470.0 45486.8 46917.1 47678.5 48011.3 48977.3 45139.5 45427.5 45528.5 45930.5 46214.0 7033.1 7088.9 7133.2 7151.7 7218.5 28599.4 29211.6 29511.0 29801.1 29868.4 35947.3 37080.3 39941.4 40028.4 40694.0 9637.6 9702.6 9807.6 9879.7 9974.6 11099.7 11146.9 11153.8 11375.9 11786.6 10419.3 10642.7 10736.7 10865.3 11003.5 10760.1 10826.8 11224.3 11289.4 11337.1 9924.5 10244.5 10419.8 10586.8 10720.1 9134.5 9505.1 9517.7 9719.0 9765.8 8835.9 9090.4 9245.5 9297.1 9327.2 12:39:23 INFO - PROCESS | 7809 | -------- Summary: end -------- 12:39:23 INFO - PROCESS | 7809 | 12:39:24 INFO - TEST-INFO | 7809: exit 0 12:39:24 INFO - TEST-OK | dromaeo_css | took 1118400ms 12:39:24 INFO - TEST-START | kraken 12:39:24 INFO - operating with platform_type : linux_ 12:39:24 INFO - Initialising browser for kraken test... 12:39:24 INFO - TEST-INFO | started process 7983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxHVYG/profile http://localhost:41599/getInfo.html) 12:39:28 INFO - PROCESS | 7983 | __metrics Screen width/height:1600/1200 12:39:28 INFO - PROCESS | 7983 | colorDepth:24 12:39:28 INFO - PROCESS | 7983 | Browser inner width/height: 1024/697 12:39:28 INFO - PROCESS | 7983 | __metrics 12:39:29 ERROR - PROCESS | 7983 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:39:30 INFO - TEST-INFO | 7983: exit 0 12:39:30 INFO - Browser initialized. 12:39:30 INFO - Running cycle 1/1 for kraken test... 12:39:30 INFO - TEST-INFO | started process 8063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxHVYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:42 INFO - PROCESS | 8063 | RSS: Main: 156233728 12:39:42 INFO - PROCESS | 8063 | 12:39:44 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41599/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:45 INFO - PROCESS | 8063 | RSS: Main: 211574784 12:39:45 INFO - PROCESS | 8063 | 12:39:48 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41599/tests/kraken/driver.html?testName=audio-dft) 12:39:49 INFO - PROCESS | 8063 | RSS: Main: 196788224 12:39:49 INFO - PROCESS | 8063 | 12:39:52 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41599/tests/kraken/driver.html?testName=audio-fft) 12:39:52 INFO - PROCESS | 8063 | RSS: Main: 268251136 12:39:52 INFO - PROCESS | 8063 | 12:39:55 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41599/tests/kraken/driver.html?testName=audio-oscillator) 12:39:55 INFO - PROCESS | 8063 | RSS: Main: 175702016 12:39:55 INFO - PROCESS | 8063 | 12:39:57 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:58 INFO - PROCESS | 8063 | RSS: Main: 179658752 12:39:58 INFO - PROCESS | 8063 | 12:40:01 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41599/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:02 INFO - PROCESS | 8063 | RSS: Main: 216330240 12:40:02 INFO - PROCESS | 8063 | 12:40:05 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41599/tests/kraken/driver.html?testName=imaging-desaturate) 12:40:06 INFO - PROCESS | 8063 | RSS: Main: 217448448 12:40:06 INFO - PROCESS | 8063 | 12:40:09 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41599/tests/kraken/driver.html?testName=json-parse-financial) 12:40:09 INFO - PROCESS | 8063 | RSS: Main: 217272320 12:40:09 INFO - PROCESS | 8063 | 12:40:11 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:40:12 INFO - PROCESS | 8063 | RSS: Main: 203157504 12:40:12 INFO - PROCESS | 8063 | 12:40:13 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:40:14 INFO - PROCESS | 8063 | RSS: Main: 206692352 12:40:14 INFO - PROCESS | 8063 | 12:40:16 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:40:17 INFO - PROCESS | 8063 | RSS: Main: 217477120 12:40:17 INFO - PROCESS | 8063 | 12:40:20 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:40:20 INFO - PROCESS | 8063 | RSS: Main: 226443264 12:40:20 INFO - PROCESS | 8063 | 12:40:23 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:24 INFO - PROCESS | 8063 | RSS: Main: 224251904 12:40:24 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | Cycle 1(1): loaded http://localhost:41599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41599/tests/kraken/driver.html?testName=ai-astar) 12:40:26 INFO - PROCESS | 8063 | RSS: Main: 287395840 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | __start_tp_report 12:40:26 INFO - PROCESS | 8063 | _x_x_mozilla_page_load 12:40:26 INFO - PROCESS | 8063 | _x_x_mozilla_page_load_details 12:40:26 INFO - PROCESS | 8063 | |i|pagename|runs| 12:40:26 INFO - PROCESS | 8063 | |0;ai-astar;112;116;109;114;114;114;101;113;112;113 12:40:26 INFO - PROCESS | 8063 | |1;audio-beat-detection;158;132;156;189;138;167;153;147;185;138 12:40:26 INFO - PROCESS | 8063 | |2;audio-dft;161;160;164;162;162;163;162;164;163;164 12:40:26 INFO - PROCESS | 8063 | |3;audio-fft;74;75;120;112;75;74;86;113;100;74 12:40:26 INFO - PROCESS | 8063 | |4;audio-oscillator;93;95;140;94;95;94;141;93;94;145 12:40:26 INFO - PROCESS | 8063 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 12:40:26 INFO - PROCESS | 8063 | |6;imaging-darkroom;146;145;145;146;145;146;146;146;146;146 12:40:26 INFO - PROCESS | 8063 | |7;imaging-desaturate;95;95;95;94;94;94;95;94;95;94 12:40:26 INFO - PROCESS | 8063 | |8;json-parse-financial;65;65;64;65;65;69;65;84;64;62 12:40:26 INFO - PROCESS | 8063 | |9;json-stringify-tinderbox;65;64;64;65;64;63;64;63;64;64 12:40:26 INFO - PROCESS | 8063 | |10;stanford-crypto-aes;78;79;78;84;86;79;80;80;80;79 12:40:26 INFO - PROCESS | 8063 | |11;stanford-crypto-ccm;139;141;133;130;129;127;130;132;166;142 12:40:26 INFO - PROCESS | 8063 | |12;stanford-crypto-pbkdf2;175;171;170;176;185;173;173;184;172;184 12:40:26 INFO - PROCESS | 8063 | |13;stanford-crypto-sha256-iterative;75;73;75;73;72;73;73;72;73;74 12:40:26 INFO - PROCESS | 8063 | __end_tp_report 12:40:26 INFO - PROCESS | 8063 | __start_cc_report 12:40:26 INFO - PROCESS | 8063 | _x_x_mozilla_cycle_collect,1905 12:40:26 INFO - PROCESS | 8063 | __end_cc_report 12:40:26 INFO - PROCESS | 8063 | __startTimestamp1461613226373__endTimestamp 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | ------- Summary: start ------- 12:40:26 INFO - PROCESS | 8063 | Number of tests: 14 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:4.21 (3.7%) stddev-sans-first:4.47 12:40:26 INFO - PROCESS | 8063 | Values: 112.0 116.0 109.0 114.0 114.0 114.0 101.0 113.0 112.0 113.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:157.00 stddev:19.35 (12.3%) stddev-sans-first:20.51 12:40:26 INFO - PROCESS | 8063 | Values: 158.0 132.0 156.0 189.0 138.0 167.0 153.0 147.0 185.0 138.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 12:40:26 INFO - PROCESS | 8063 | Values: 161.0 160.0 164.0 162.0 162.0 163.0 162.0 164.0 163.0 164.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#3] audio-fft Cycles:10 Average:90.30 Median:74.00 stddev:18.99 (25.7%) stddev-sans-first:19.21 12:40:26 INFO - PROCESS | 8063 | Values: 74.0 75.0 120.0 112.0 75.0 74.0 86.0 113.0 100.0 74.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:23.23 (24.7%) stddev-sans-first:23.96 12:40:26 INFO - PROCESS | 8063 | Values: 93.0 95.0 140.0 94.0 95.0 94.0 141.0 93.0 94.0 145.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:40:26 INFO - PROCESS | 8063 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:40:26 INFO - PROCESS | 8063 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 12:40:26 INFO - PROCESS | 8063 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.00 stddev:6.29 (9.7%) stddev-sans-first:6.63 12:40:26 INFO - PROCESS | 8063 | Values: 65.0 65.0 64.0 65.0 65.0 69.0 65.0 84.0 64.0 62.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 12:40:26 INFO - PROCESS | 8063 | Values: 65.0 64.0 64.0 65.0 64.0 63.0 64.0 63.0 64.0 64.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:2.63 (3.3%) stddev-sans-first:2.65 12:40:26 INFO - PROCESS | 8063 | Values: 78.0 79.0 78.0 84.0 86.0 79.0 80.0 80.0 80.0 79.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.00 stddev:11.49 (8.5%) stddev-sans-first:12.17 12:40:26 INFO - PROCESS | 8063 | Values: 139.0 141.0 133.0 130.0 129.0 127.0 130.0 132.0 166.0 142.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:175.50 stddev:5.81 (3.3%) stddev-sans-first:6.15 12:40:26 INFO - PROCESS | 8063 | Values: 175.0 171.0 170.0 176.0 185.0 173.0 173.0 184.0 172.0 184.0 12:40:26 INFO - PROCESS | 8063 | 12:40:26 INFO - PROCESS | 8063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:1.06 (1.5%) stddev-sans-first:0.93 12:40:26 INFO - PROCESS | 8063 | Values: 75.0 73.0 75.0 73.0 72.0 73.0 73.0 72.0 73.0 74.0 12:40:26 INFO - PROCESS | 8063 | -------- Summary: end -------- 12:40:26 INFO - PROCESS | 8063 | 12:40:27 INFO - TEST-INFO | 8063: exit 0 12:40:27 INFO - TEST-OK | kraken | took 63237ms 12:40:27 INFO - SUITE-END | took 1181s 12:40:27 INFO - Completed test suite (00:19:41) 12:40:27 INFO - javascript benchmark 12:40:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.947581048379, 2651.4829608226405, 2707.729227077292, 2716.1036857836916, 2736.9178924632256, 4613.769311534426, 4674.579287864091, 4716.55192756688, 4726.078414709129, 4773.761311934402, 4668.159731248374, 4728.692634978724, 4748.5726284634375, 4750.049990001996, 4750.358701575286, 4216.536181020086, 4258.872233832983, 4274.487061552618, 4302.182585308797, 4446.021875187454, 4378.233809083414, 4400.427944367228, 4403.471583409995, 4448.510663826976, 4453.799579018936, 4298.26929421999, 4309.310510318334, 4361.956380436202, 4365.257906155961, 4396.340548917656, 4321.567843215685, 4352.956470435319, 4362.236608593484, 4365.716228445141, 4402.0, 4314.870553883388, 4319.157764235975, 4331.675124365685, 4336.588024137702, 4384.12317536494, 4422.778861056967, 4548.772561371951, 4590.74750888701, 4637.582617564435, 4669.369635099252, 5069.746512674388, 5088.211327244283, 5089.770960306795, 5097.082525145473, 5122.257272695476, 5090.287359769598, 5097.9490205097845, 5101.642884998052, 5108.770105345268, 5119.718415487147, 4642.210824159867, 4736.763161841963, 4751.168545504523, 4823.734694591761, 4830.468648448667, 5243.685378877203, 5251.0548101341365, 5258.1849813279005, 5269.1569348903995, 5276.947230527722, 5024.497550244946, 5029.874253143627, 5030.270610761419, 5034.647574669812, 5071.163258062378, 4960.355153829979, 5037.244413338029, 5072.644914855925, 5121.590272778169, 5125.410577783603, 4970.527799859007, 5022.7990880365105, 5024.874378140503, 5027.748612569357, 5076.2131869559535, 4832.903341933142, 4991.600671946236, 5004.774785134678, 5009.223570346602, 5016.297718319438, 4229.175310814362, 4267.146570685875, 4330.242207613655, 4341.110072435144, 4341.804618792162, 3716.1267102230954, 3753.49327840738, 3763.849446022183, 3794.354959656865, 3799.0122568131933, 4422.115576884636, 4447.399601053881, 4450.666200034945, 4451.7996690148375, 4495.1234509271035, 4900.754962251873, 5037.571806396498, 5050.343455350854, 5076.796928122908, 5078.898422031539, 4342.82628694855, 4366.083122544238, 4432.29083346663, 4433.667474939392, 4470.888227794266, 4498.820047198141, 4582.518835522222, 4583.679142459996, 4583.977080114645, 4617.976910115495, 4725.763711814464, 4756.23900175984, 4768.976155119202, 4813.566778989908, 4815.590674792542, 5037.697738135724, 5076.36545431821, 5089.465606111453, 5108.974455127701, 5118.948810511847, 4695.154872122914, 4767.952320476751, 4788.970371370172, 4811.350467686958, 4851.587615052619, 5002.724850133278, 5029.874253143555, 5032.773525191448, 5034.798608055637, 5064.873378165576, 5089.745512724423, 5096.23556466533, 5099.158638824552, 5110.8466745997675, 5117.718525480986, 4817.421909370758, 4943.752812359439, 4950.9257361140335, 4954.232094025288, 5032.748362581783, 4955.083309587738, 4976.029674213493, 4977.875553111201, 4984.775685094107, 4999.77501012448, 4882.316475693477, 4900.705957642553, 4904.166291730343, 4905.975470122627, 4935.75321233944, 4816.518348165156, 4844.46710861812, 4973.079980203674, 5028.270900719302, 5040.36995375578, 4698.154332220233, 4755.453122890912, 4758.405199350082, 4759.024399998061, 4880.780364883518], "value": 4654.642275364057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4982666246453, 587.7384563869078, 596.064179238595, 605.4671888737911, 607.8571535689115, 26397.07610233642, 34301.82849085757, 34517.30965380694, 34968.65031349686, 35249.295014099735, 36995.445068324, 37490.25019499615, 37566.24867502655, 37685.24629507408, 37763.811180944125, 7207.639618019104, 7615.466917315804, 7830.216978302181, 7832.255935686101, 7834.647440865175, 9817.901820981806, 9851.0, 9859.063388978071, 9859.654912078078, 9900.90099099007, 9859.211263098934, 10017.19862411009, 10029.297949143564, 10029.498525073754, 10030.247731420137, 9702.805943881118, 9844.474106513502, 9853.162481189107, 9855.162311203556, 9862.260330475172, 9729.075737804897, 9889.456079915602, 9904.0, 10138.935411781731, 10183.236257280734, 26014.479710405685, 26730.331741706614, 26745.0, 26760.253564500985, 38329.42505862414, 2788.4980703473366, 2829.9292517687018, 2841.0, 2857.1857020749194, 2907.7092290770966, 27338.589921151197, 27393.726062739315, 27429.588556171675, 27693.723062769317, 27758.722412776016, 3348.414027545194, 3403.1322012886803, 3407.47184186449, 3408.3183363327435, 3485.75599708018, 173695.0, 177032.99999999872, 177305.0, 178102.0, 178288.0, 55138.72430637821, 56348.71825640927, 56365.15452268219, 56390.0, 56400.43599563952, 59520.70239648774, 59690.0, 59758.103628445606, 59797.701011495534, 59930.700346497986, 14511.927440362731, 15047.548573542812, 15051.623709407353, 15053.473128440672, 15054.548363549111, 10228.64199753005, 10485.737856553647, 10497.370157790558, 10498.947505262577, 11170.329780213051, 17455.73816392755, 17870.731939020927, 17958.820411795714, 18022.64573318827, 18106.547336316697, 6901.896471552931, 6928.515003949675, 7263.709451621876, 7316.743913962986, 7351.705931762776, 767.8924950506934, 832.7876391520124, 893.8748575199477, 961.8845738511284, 1024.6977141743055, 26949.595756063674, 28109.859450703025, 28115.71884281131, 28537.71462285392, 28720.0, 946.9857952130724, 976.4190306767462, 1026.8819085805078, 1049.5539395756773, 1077.5258886090253, 14690.11859288446, 15164.469243576423, 15263.313150908014, 15359.385624574892, 15504.767428488582, 317105.0, 320265.0, 320898.0, 323202.0, 323225.0, 50086.0, 51050.23424648633, 51074.0, 51097.0, 51145.48854511407, 1088.8530048443517, 1203.5907791350808, 1216.2823933878876, 1220.9865811376715, 1308.032056278366, 24294.78526073654, 25344.239672809847, 26040.218793436226, 26318.736812632396, 26370.73629263683, 36166.457503138, 36455.27089458249, 36753.816230918674, 36762.448563271035, 36816.44775328426, 180729.0, 181561.0, 181977.0, 182485.0, 182957.0, 28183.0, 32612.184695382806, 33045.83477082599, 33163.35203127606, 33373.83313083419, 38183.0, 40362.0, 40503.59496404998, 40722.1855562893, 41299.58700412957, 33827.492587610715, 34648.30703385868, 34898.47652285167, 35186.824065879504, 35251.64748352484, 34461.0, 34709.47935780915, 34776.30447391089, 34790.13024674403, 35273.823630881685, 33792.324153517286, 34597.48103778395, 34616.0, 34886.82556587201, 34912.825435872655, 30191.0, 30779.384412312076, 30790.846045769627, 30826.0, 30961.380772383975, 23939.88030059908, 24145.879270603535, 24272.0, 24611.261662150166, 24620.87689561541], "value": 17139.78648252613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.0864017717301, 389.1963096206334, 392.51916402407056, 396.68317876763115, 399.53454225826914, 16152.273147708353, 16535.66928661429, 16642.334306627734, 16663.41678041269, 16703.08133052683, 16050.518484445485, 16451.0, 16873.83126168738, 16975.57561060974, 17361.91319043406, 5010.498950104997, 5179.585633149339, 5202.973985130088, 5221.895562088756, 5222.268882356473, 5103.106956282654, 5128.769205385748, 5193.480651934814, 5195.142801437758, 5198.818041368553, 5008.924866127011, 5114.232865070232, 5129.512696293846, 5135.024345374367, 5136.178211486163, 5056.266841308008, 5095.3376061112, 5135.717535535544, 5137.768800403972, 5140.3060586820675, 4450.132224216279, 4571.542845715435, 4610.746408947506, 4620.6303495720595, 4625.398698169217, 10582.841257381146, 20504.43694538183, 21337.466563335885, 21359.466013349636, 21375.358739237847, 1797.973030404545, 1810.97283540747, 1819.3359423810346, 1821.9362322318655, 2166.729158855143, 8982.461052336881, 8991.100889911022, 9075.18323350895, 9166.908330916738, 9410.670626528106, 1744.5725797179646, 1849.7225416187546, 1854.1563588567305, 1865.813418658137, 1933.1494142577221, 68821.0, 71586.284137159, 71878.0, 72266.0, 72320.2767972324, 9974.850377244347, 10048.849267260997, 10162.644307449204, 10192.0, 10393.53229104692, 14042.719145617235, 14158.292085395895, 14172.362243699059, 14186.503472378417, 14204.147751134966, 7384.1877393486675, 7385.29839665231, 7469.178390377054, 7486.4759466836795, 7635.69457221716, 7259.603913147245, 7272.094295518931, 7335.596542190124, 7421.962890185515, 7441.776746697607, 4265.978670106691, 4314.590113939171, 4349.956500435019, 4438.556144385536, 4446.288593824973, 1816.9454916352531, 1826.5159732670852, 1845.8431033362315, 1845.898475583829, 1920.5870737791442, 845.6617353058703, 877.9385443019055, 888.9733308000771, 900.3607438718452, 907.945523268606, 15707.0, 16005.67988640244, 16296.42962496307, 16482.75275870863, 16664.0, 851.3274513134678, 855.5294587976588, 859.0679113162164, 891.9875940807101, 914.0695011450736, 9180.265578753684, 9520.047995200424, 9566.808663826685, 9659.372140810825, 9671.32939899806, 273687.0, 278423.0, 279059.0, 282687.0, 332348.0, 75338.62330688421, 77963.61018194872, 78398.6080069596, 85149.0, 86077.0, 947.062408215875, 948.1229862377273, 973.7176218896583, 978.882534095913, 982.9066238707311, 15438.45965391206, 15722.05667659944, 15736.29186686579, 15787.447439339569, 16074.919625401799, 36065.27869442649, 36257.0, 36867.0, 37413.25173496569, 37491.250174996894, 50337.49662503328, 51766.223506646675, 51820.0, 51849.740751296005, 52271.47728522666, 7315.707371705073, 7354.742584009534, 7471.290227428385, 7505.962470187833, 7680.769576912701, 10809.67570972872, 11532.654020379403, 11724.824127637921, 11781.882181178078, 11800.910754988994, 9756.365836220622, 10255.94872025635, 10392.948035259775, 10522.158227341948, 10607.787844243227, 9638.759031024, 9683.951580242054, 10240.18078553699, 10328.431936243578, 10380.0, 5210.53105220532, 7778.533288002738, 9082.59128339213, 10370.533326000197, 10370.688879333633, 7519.473636845369, 7573.0, 7582.734604288823, 7747.612619369122, 7924.6830126796585, 7694.461387702807, 8823.338249631432, 9378.437293762396, 10055.597776089167, 10450.68647940563], "value": 8056.707592525862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.1341654133837, 1449.521657852909, 1465.1941432212282, 1580.6048487878031, 1763.929442822288, 7243.384312333452, 7599.316061554459, 7602.125755538108, 7602.163761986177, 7608.809779755509, 7354.080739907512, 7531.397488200944, 7533.982912306837, 7535.698572057111, 7540.622968851563, 1888.726134710466, 1956.158851693771, 1961.2743284984504, 2199.7910198531113, 2240.2943072932057, 2179.3679832848456, 2234.307364716943, 2234.977650223493, 2237.697910782048, 2240.5854916840353, 2129.127057906259, 2142.1217300906633, 2153.881536515491, 2156.91372345106, 2175.7824217578273, 1890.3383815664545, 2160.6326924422888, 2171.1206961180746, 2181.4110190248543, 2182.050807898569, 2183.8034576888, 2188.234118058667, 2209.7127373441513, 2215.6122678531356, 2215.678726584636, 7180.640967951582, 7251.0, 7259.963700181518, 7261.2012678605315, 7263.201047884729, 4384.671149663756, 4542.250528662767, 4547.8635640930825, 4570.314452832068, 4572.314152877095, 2762.861856907167, 2815.8310501369983, 2926.4293462774767, 2943.2200466876293, 2950.3361743607516, 873.76845136039, 880.9075047120024, 883.2889523933231, 883.6200433813458, 885.5572213893054, 10175.338602990782, 10422.583096676048, 10425.374477531297, 10448.477576121164, 10457.267991240617, 4243.42713733642, 4276.550962148992, 4404.55954404557, 4451.265541185733, 4454.7549884756, 8987.685431010013, 9060.501672408082, 9068.138526839939, 9087.454752714859, 9093.181613654802, 4759.690620109682, 4781.593564546983, 4792.472827988919, 4796.160671882407, 4799.832005879777, 3689.870854520079, 4165.416841642173, 4313.633341166036, 4318.114786468766, 4326.329418940069, 3659.4876717259604, 3664.2305115925956, 3748.55017397914, 3767.05823544114, 3795.3927371620407, 1204.8614409342863, 1214.5445457953267, 1239.863615002349, 1252.6993521554944, 1253.4547471849774, 711.5375006245878, 728.388153950684, 734.4271468254769, 749.7001199520236, 757.5189754505928, 4718.31584420264, 4782.52174782519, 4811.78346974387, 4815.398075240595, 4997.075541024922, 404.1613651672732, 421.1913126796558, 424.8959005043784, 426.0180284444385, 427.8010725012884, 3232.935341293208, 3282.885099021523, 3318.5851768528933, 3330.9333813323597, 3373.7132343750563, 8988.191062804248, 9402.730631364679, 9546.236301095896, 9557.761055973517, 9586.95206523963, 8405.0, 8717.52053637056, 8736.25741811953, 8861.73414797557, 9457.33798634089, 6821.420179284816, 6915.965420172967, 6916.515843890879, 6962.756303529352, 6973.0, 5249.47505249472, 5319.095753721799, 5399.487048730364, 5473.179023146401, 5478.178273259043, 8512.70205542803, 8924.821503570021, 8969.058248883774, 9029.458232506071, 9045.592948317473, 8807.928531546693, 8842.557872106498, 8876.911230887608, 8925.910740892508, 9105.135012173832, 6017.969910150421, 6187.412195841388, 6191.876162476815, 6714.093597364294, 6869.7595584154315, 5731.541476681772, 6499.935000650122, 6870.690818913061, 6916.23921368639, 6918.792436226921, 6216.067589861557, 6243.531735119794, 6316.0, 6336.58812177207, 6383.840403989938, 6070.878582428415, 6098.786542470993, 6103.023516237381, 6120.326764056039, 6222.439980401786, 5521.503064724194, 5603.159526071122, 5655.604107712421, 5848.064309710426, 5858.94141058584, 4218.43051188098, 4359.760213188305, 4395.8021889014435, 4455.777211139365, 4495.640348772155, 4315.708201539214, 4336.1978034063795, 4377.518472967908, 4425.446819147606, 4448.0], "value": 3935.3485989196197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1610144558968, 311.1226341716361, 312.9514925186594, 314.292841107508, 314.49837509172863, 4734.360861283726, 4804.951950480498, 4812.9518704812945, 4815.494373090827, 4823.324734537163, 4650.3024546318065, 4705.388299521066, 4708.482066972639, 4724.48816378759, 4733.171694953387, 3544.751867369279, 3573.94639080414, 3645.143391303042, 3750.474933509311, 3753.3244016077097, 3632.4551317302353, 3726.8260497943197, 3736.9252614947686, 3740.7007439404783, 3743.51056547397, 3688.391415416453, 3706.2587482503473, 3722.367197576405, 3727.6458736419995, 3737.2338670572467, 3519.0293435675976, 3593.7843729376323, 3722.925541489155, 3737.4206997915367, 3756.8309426075893, 3326.9500957485657, 3331.1339051846453, 3332.950005749916, 3340.699337059652, 3351.4302568563403, 4506.031203291275, 4536.296873984537, 4538.160440318518, 4555.111753208126, 4568.1548913451115, 3983.880483585497, 4190.643795277405, 4245.490541135053, 4260.786960651955, 4278.550752171009, 4934.5312195341385, 4936.259561065869, 4948.752562371903, 4950.43070046942, 4950.43070046942, 3532.947005794915, 3549.8225088745717, 3551.8401671924826, 3579.266250418658, 3587.282543491286, 5059.1905295152965, 5179.482051794828, 5212.765425555821, 5236.6857988520815, 5264.973675131638, 3628.4920111184456, 3630.2920930418313, 3641.1443310821937, 3657.195417008254, 3661.1213308806227, 3668.248009158116, 3668.63313668631, 3694.983879433177, 3701.2782507411334, 3710.8144592770795, 4179.97910010448, 4189.895252618709, 4206.642435392964, 4212.936805947913, 4219.261629214875, 4872.171730805771, 4976.377952755905, 5000.474950130257, 5015.774290156952, 5023.919857230713, 1337.8026666133755, 1344.7108871592654, 1345.9434344039882, 1352.7159296547638, 1355.3494322725146, 855.9101294364127, 879.3404946290283, 900.0324651000201, 923.2429407885469, 927.1794461901266, 4354.542773008852, 4456.665750068758, 4626.375439315717, 4626.606738427204, 4630.745309008037, 5123.487651234846, 5165.502004418751, 5180.404253510895, 5182.585393168538, 5189.558887494605, 4304.246756817544, 4471.485779135376, 4494.325851122358, 4499.437570303712, 4511.481179664315, 2882.962133631891, 2888.566714992768, 2889.7688184945155, 2911.315840777416, 2915.25660956459, 5138.152204886152, 5140.537351638371, 5164.354455693038, 5166.509181627739, 5168.715720635401, 5392.946070539323, 5573.303337082864, 5573.944260557342, 5595.972020139955, 5609.4390560943575, 5107.846764596994, 5112.539871411591, 5126.666766660155, 5141.401019286514, 5151.7681704323395, 5423.0, 5440.470181365684, 5471.0, 5484.149956756709, 5491.341039075177, 5145.511176438233, 5320.201969704421, 5338.733063346895, 5352.734831752706, 5376.139817629317, 5120.564751995973, 5125.641205115606, 5145.742712864417, 5152.381714194321, 5170.922436163385, 3917.451556781996, 3949.881503554898, 3951.6838652908273, 3963.3262345400776, 3963.553303044426, 5264.921026184534, 5413.40452550227, 5417.133258678593, 5440.782368705208, 5444.292242008513, 5196.922046169235, 5231.529162375405, 5236.214567814858, 5239.764210610456, 5243.423223445494, 5216.035033518811, 5229.92155117666, 5240.68555886648, 5245.344331958505, 5247.396549396715, 5018.447970723145, 5141.100307446257, 5147.948520514747, 5175.948240517697, 5196.68819870809, 4714.811407543797, 4831.347768051268, 4944.381952255968, 4991.376077990251, 4997.900041999213, 4890.755462226945, 4921.901561968669, 4924.236743304794, 4929.693631187666, 4948.208286674115], "value": 3853.7472039800164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.3161070238791, 640.1773720768813, 655.9832259997004, 690.6408667492904, 745.6309126982145, 11986.400679966011, 12015.819762703555, 12202.206856554329, 12255.509779608827, 12291.139620226566, 11927.940360298186, 11943.940280298586, 11963.0, 11977.401129943511, 11987.580434684787, 635.920509936258, 775.3642013548892, 790.044046703488, 803.7508372404544, 806.7821688144197, 794.1740589786643, 800.8438354520871, 802.1256830055239, 802.2699343597328, 803.3773825285422, 836.477201748907, 837.401258100458, 838.5010918503481, 838.6226198210799, 838.6310023589632, 660.7819419591523, 822.7490615362312, 835.0, 845.5518575155178, 846.5597889097696, 618.6411881108946, 619.6777675608703, 619.7582942652369, 620.3610281410155, 620.9844753881144, 11504.482298296596, 11604.76790464186, 11691.356975366352, 11694.824577631342, 11759.588414405454, 11947.223430476992, 12184.695382615506, 12264.816027759502, 12272.32502212378, 12308.630741077692, 10030.9498452508, 10060.144887684555, 10109.646162384355, 10143.695689129338, 10269.486525673761, 3251.902442926716, 3309.619393769699, 3320.833958302075, 3325.7505687073326, 3351.8324083795715, 43446.348304775456, 43497.0, 43621.0, 45026.77486612579, 45281.320780188325, 9785.755356116011, 9830.557624906896, 9982.850257246148, 9990.80018399628, 10040.0, 16533.256003479873, 16955.067471289196, 16957.915210423867, 16970.0, 17024.91487542579, 6373.235211774524, 6428.067930150196, 6474.1907261592305, 6550.475961923034, 6733.0, 3449.862005519801, 3464.566929133858, 3486.1110416843544, 3515.226650136966, 3540.097275194809, 2795.398989217328, 2842.019503271368, 2847.18855126288, 2849.6437945256844, 2856.3287627407544, 500.96994180348565, 506.5668853130594, 517.1751057063977, 521.4889408379809, 522.5975998481148, 570.589175793428, 606.2119244981507, 606.2388760650318, 606.9484093852072, 610.9480694141048, 7156.92843071573, 7349.375303099189, 7446.0, 7549.131849837229, 7647.502912310682, 586.8972929737279, 599.1462166412845, 606.1029676079427, 615.2647586134616, 626.4737620398887, 2928.194746444702, 3035.2867076237067, 3047.1620304416465, 3061.540768884685, 3070.831104289241, 53780.0, 55605.165922511194, 56026.0, 57359.426405736245, 57470.0, 45486.772566136955, 46917.061658767314, 47678.5232147681, 48011.27983080257, 48977.26534101991, 45139.54860451353, 45427.54572454299, 45528.54471455309, 45930.54069459329, 46214.0, 7033.120859892513, 7088.930140892883, 7133.215346312006, 7151.749688760869, 7218.458615603746, 28599.42801144007, 29211.561826572193, 29511.0, 29801.10596682103, 29868.402631946803, 35947.28105437929, 37080.25839483249, 39941.40087898742, 40028.399574006995, 40694.0, 9637.566309516229, 9702.563384647567, 9807.607695692377, 9879.703608891745, 9974.55114519863, 11099.72250693739, 11146.944265278622, 11153.776924461628, 11375.886241137483, 11786.587469438871, 10419.270651054354, 10642.73393165177, 10736.73158171052, 10865.293755905841, 11003.504842281956, 10760.085392741392, 10826.837597436202, 11224.270422422516, 11289.435528223721, 11337.09303255721, 9924.454155021544, 10244.538995745359, 10419.791604167722, 10586.8411973822, 10720.088792452729, 9134.451932884049, 9505.144536991704, 9517.714468565953, 9718.986495587358, 9765.755856103655, 8835.867461988204, 9090.409123406956, 9245.537723113683, 9297.116773906468, 9327.191319110167], "value": 5788.308008012022, "unit": "score"}], "name": "dromaeo_css", "value": 6193.263275024798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 109.0, 114.0, 114.0, 114.0, 101.0, 113.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 156.0, 189.0, 138.0, 167.0, 153.0, 147.0, 185.0, 138.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 164.0, 162.0, 162.0, 163.0, 162.0, 164.0, 163.0, 164.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 120.0, 112.0, 75.0, 74.0, 86.0, 113.0, 100.0, 74.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 140.0, 94.0, 95.0, 94.0, 141.0, 93.0, 94.0, 145.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 69.0, 65.0, 84.0, 64.0, 62.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 84.0, 86.0, 79.0, 80.0, 80.0, 80.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 133.0, 130.0, 129.0, 127.0, 130.0, 132.0, 166.0, 142.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 170.0, 176.0, 185.0, 173.0, 173.0, 184.0, 172.0, 184.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 73.0, 72.0, 73.0, 73.0, 72.0, 73.0, 74.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1583.9999999999998, "alertThreshold": 2.0}]} 12:40:27 INFO - Return code: 0 12:40:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:40:27 ERROR - # TBPL SUCCESS # 12:40:27 INFO - Running post-action listener: _resource_record_post_action 12:40:27 INFO - Running post-run listener: _resource_record_post_run 12:40:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518230016; Read time: 8; Write time: 434524 12:40:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234778624; Read time: 0; Write time: 266012 12:40:28 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283451392; Read time: 8; Write time: 168512 12:40:28 INFO - Running post-run listener: _upload_blobber_files 12:40:28 INFO - Blob upload gear active. 12:40:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:28 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 12:40:28 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'] 12:40:28 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 12:40:29 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:30 INFO - (blobuploader) - INFO - Done attempting. 12:40:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:30 INFO - (blobuploader) - INFO - Done attempting. 12:40:30 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:30 INFO - Return code: 0 12:40:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6dadfedc39ab3885640e1cf54303fc46addf881f5e0005194e7ffce1592201f5a7e99c2d1112a0e654e41aeee11da6b4f40bda6ef88d45b3cca73a5b799f9e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/91b316b7198fa657d9732860a7b6bffdd2c98081c5ea7b3ee786ef3bf277c27e0317d55bcab9366faaa800ba8c97d2afebe4965e48518dc168a82f09b4287d22"} 12:40:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:30 INFO - Contents: 12:40:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6dadfedc39ab3885640e1cf54303fc46addf881f5e0005194e7ffce1592201f5a7e99c2d1112a0e654e41aeee11da6b4f40bda6ef88d45b3cca73a5b799f9e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/91b316b7198fa657d9732860a7b6bffdd2c98081c5ea7b3ee786ef3bf277c27e0317d55bcab9366faaa800ba8c97d2afebe4965e48518dc168a82f09b4287d22"} 12:40:30 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:30 INFO - Copying logs to upload dir... 12:40:30 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.616388 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-25 12:40:30.779353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 12:40:30.783250) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 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/f6dadfedc39ab3885640e1cf54303fc46addf881f5e0005194e7ffce1592201f5a7e99c2d1112a0e654e41aeee11da6b4f40bda6ef88d45b3cca73a5b799f9e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/91b316b7198fa657d9732860a7b6bffdd2c98081c5ea7b3ee786ef3bf277c27e0317d55bcab9366faaa800ba8c97d2afebe4965e48518dc168a82f09b4287d22"} build_url:https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/CN3ULy3iTvOgH-1r3T0qBg/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/f6dadfedc39ab3885640e1cf54303fc46addf881f5e0005194e7ffce1592201f5a7e99c2d1112a0e654e41aeee11da6b4f40bda6ef88d45b3cca73a5b799f9e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/91b316b7198fa657d9732860a7b6bffdd2c98081c5ea7b3ee786ef3bf277c27e0317d55bcab9366faaa800ba8c97d2afebe4965e48518dc168a82f09b4287d22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 12:40:30.811488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:40:30.811855) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461611450.845377-386462573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:40:30.894783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:40:30.895127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:40:30.895460) ========= ========= Total master_lag: 0.28 =========