builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1462480589.14 results: success (0) buildid: 20160505115951 builduid: a3900348d57d4f5182d62db566e27050 revision: e4e6e8589b76d09f1fa43186cbca61bdac430254 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.142213) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.142927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.143436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.160562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.160850) ========= 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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 13:36:29-- 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% 35.4M=0s 2016-05-05 13:36:29 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.283654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.283986) ========= 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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.334650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:29.335326) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4e6e8589b76d09f1fa43186cbca61bdac430254 --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 e4e6e8589b76d09f1fa43186cbca61bdac430254 --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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 13:36:29,533 truncating revision to first 12 chars 2016-05-05 13:36:29,533 Setting DEBUG logging. 2016-05-05 13:36:29,533 attempt 1/10 2016-05-05 13:36:29,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4e6e8589b76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 13:36:29,985 unpacking tar archive at: fx-team-e4e6e8589b76/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:30.116794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:30.117183) ========= script_repo_revision: e4e6e8589b76d09f1fa43186cbca61bdac430254 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:30.117664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:30.117948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 13:36:30.127125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-05 13:36:30.127406) ========= /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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:36:30 INFO - MultiFileLogger online at 20160505 13:36:30 in /builds/slave/test 13:36:30 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 13:36:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:36:30 INFO - {'append_to_log': False, 13:36:30 INFO - 'base_work_dir': '/builds/slave/test', 13:36:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:36:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:36:30 INFO - 'branch': 'Fx-Team-Non-PGO', 13:36:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:36:30 INFO - 'config_files': ('talos/linux_config.py',), 13:36:30 INFO - 'default_actions': ('clobber', 13:36:30 INFO - 'read-buildbot-config', 13:36:30 INFO - 'download-and-extract', 13:36:30 INFO - 'populate-webroot', 13:36:30 INFO - 'create-virtualenv', 13:36:30 INFO - 'install', 13:36:30 INFO - 'run-tests'), 13:36:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:36:30 INFO - 'download_minidump_stackwalk': True, 13:36:30 INFO - 'download_symbols': 'ondemand', 13:36:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:36:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:36:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:36:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:36:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:36:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:36:30 INFO - 'installer_path': 'installer.exe', 13:36:30 INFO - 'log_level': 'info', 13:36:30 INFO - 'log_name': 'talos', 13:36:30 INFO - 'log_to_console': True, 13:36:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:36:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:36:30 INFO - 'opt_config_files': (), 13:36:30 INFO - 'pip_index': False, 13:36:30 INFO - 'sps_profile': False, 13:36:30 INFO - 'sps_profile_interval': 0, 13:36:30 INFO - 'suite': 'dromaeojs', 13:36:30 INFO - 'system_bits': '32', 13:36:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:36:30 INFO - 'title': 'talos-linux64-ix-021', 13:36:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:36:30 INFO - 'use_talos_json': True, 13:36:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:36:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:36:30 INFO - 'work_dir': 'build'} 13:36:30 INFO - ##### 13:36:30 INFO - ##### Running clobber step. 13:36:30 INFO - ##### 13:36:30 INFO - Running pre-action listener: _resource_record_pre_action 13:36:30 INFO - Running main action method: clobber 13:36:30 INFO - rmtree: /builds/slave/test/build 13:36:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:36:31 INFO - Running post-action listener: _resource_record_post_action 13:36:31 INFO - ##### 13:36:31 INFO - ##### Running read-buildbot-config step. 13:36:31 INFO - ##### 13:36:31 INFO - Running pre-action listener: _resource_record_pre_action 13:36:31 INFO - Running main action method: read_buildbot_config 13:36:31 INFO - Using buildbot properties: 13:36:31 INFO - { 13:36:31 INFO - "project": "", 13:36:31 INFO - "product": "firefox", 13:36:31 INFO - "script_repo_revision": "production", 13:36:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:36:31 INFO - "repository": "", 13:36:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:36:31 INFO - "buildid": "20160505115951", 13:36:31 INFO - "pgo_build": "False", 13:36:31 INFO - "basedir": "/builds/slave/test", 13:36:31 INFO - "buildnumber": 1729, 13:36:31 INFO - "slavename": "talos-linux64-ix-021", 13:36:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:36:31 INFO - "platform": "ubuntu64_hw", 13:36:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:36:31 INFO - "branch": "fx-team", 13:36:31 INFO - "repo_path": "integration/fx-team", 13:36:31 INFO - "revision": "e4e6e8589b76d09f1fa43186cbca61bdac430254", 13:36:31 INFO - "stage_platform": "linux64", 13:36:31 INFO - "builduid": "a3900348d57d4f5182d62db566e27050", 13:36:31 INFO - "slavebuilddir": "test" 13:36:31 INFO - } 13:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:36:31 INFO - Running post-action listener: _resource_record_post_action 13:36:31 INFO - ##### 13:36:31 INFO - ##### Running download-and-extract step. 13:36:31 INFO - ##### 13:36:31 INFO - Running pre-action listener: _resource_record_pre_action 13:36:31 INFO - Running main action method: download_and_extract 13:36:31 INFO - mkdir: /builds/slave/test/build/tests 13:36:31 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')]} 13:36:31 INFO - https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:36:32 INFO - Downloaded 1361 bytes. 13:36:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:36:32 INFO - Using the following test package requirements: 13:36:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:36:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:36:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:36:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'jsshell-linux-x86_64.zip'], 13:36:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:36:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:36:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:36:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:36:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:36:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:36:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:36:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:32 INFO - https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:36:34 INFO - Downloaded 22309108 bytes. 13:36:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:36:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:36:35 INFO - Return code: 0 13:36:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:35 INFO - https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:36:36 INFO - Downloaded 22309108 bytes. 13:36:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:36:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:36:38 INFO - Return code: 0 13:36:38 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')]} 13:36:38 INFO - https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:36:39 INFO - Downloaded 10840152 bytes. 13:36:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:36:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:36:39 INFO - Return code: 0 13:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:39 INFO - https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:36:41 INFO - Downloaded 54838263 bytes. 13:36:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:36:41 INFO - mkdir: /builds/slave/test/properties 13:36:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:36:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:36:41 INFO - Contents: 13:36:41 INFO - build_url:https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:36:42 INFO - Running post-action listener: _resource_record_post_action 13:36:42 INFO - Running post-action listener: set_extra_try_arguments 13:36:42 INFO - ##### 13:36:42 INFO - ##### Running populate-webroot step. 13:36:42 INFO - ##### 13:36:42 INFO - Running pre-action listener: _resource_record_pre_action 13:36:42 INFO - Running main action method: populate_webroot 13:36:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:36:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:36:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:36:42 INFO - '--tppagecycles', 13:36:42 INFO - '7'], 13:36:42 INFO - 'tests': ['tsvgm']}}, 13:36:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:36:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:36:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:36:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:36:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['damp', 'tps']}, 13:36:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'tests': ['damp', 'tps']}, 13:36:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['dromaeo_dom']}, 13:36:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:36:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['a11yr', 13:36:42 INFO - 'ts_paint', 13:36:42 INFO - 'tpaint', 13:36:42 INFO - 'sessionrestore', 13:36:42 INFO - 'sessionrestore_no_auto_restore', 13:36:42 INFO - 'tabpaint']}, 13:36:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['tsvgx', 13:36:42 INFO - 'tsvgr_opacity', 13:36:42 INFO - 'tart', 13:36:42 INFO - 'tscrollx', 13:36:42 INFO - 'cart']}, 13:36:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:36:42 INFO - 'tsvgr_opacity', 13:36:42 INFO - 'tart', 13:36:42 INFO - 'tscrollx', 13:36:42 INFO - 'cart']}, 13:36:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'talos_options': ['--disable-e10s'], 13:36:42 INFO - 'tests': ['tp5o']}, 13:36:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'tests': ['tp5o']}, 13:36:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'talos_options': ['--disable-e10s', 13:36:42 INFO - '--xperf_path', 13:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:42 INFO - 'tests': ['tp5n']}, 13:36:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:42 INFO - 'talos_options': ['--xperf_path', 13:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:42 INFO - 'tests': ['tp5n']}}, 13:36:42 INFO - 'talos.zip': {'path': '', 13:36:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:36:42 INFO - Running post-action listener: _resource_record_post_action 13:36:42 INFO - ##### 13:36:42 INFO - ##### Running create-virtualenv step. 13:36:42 INFO - ##### 13:36:42 INFO - Running pre-action listener: _resource_record_pre_action 13:36:42 INFO - Running main action method: create_virtualenv 13:36:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:36:42 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 13:36:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:36:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:36:42 INFO - Using real prefix '/usr' 13:36:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:36:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:36:44 INFO - Installing pip.................done. 13:36:44 INFO - Return code: 0 13:36:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:44 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:44 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 13:36:44 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 13:36:44 INFO - Using env: {'DISPLAY': ':0', 13:36:44 INFO - 'HOME': '/home/cltbld', 13:36:44 INFO - 'LANG': 'en_US.UTF-8', 13:36:44 INFO - 'LANGUAGE': 'en_US:en', 13:36:44 INFO - 'LOGNAME': 'cltbld', 13:36:44 INFO - 'MAIL': '/var/mail/cltbld', 13:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:44 INFO - 'MOZ_NO_REMOTE': '1', 13:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:44 INFO - 'NO_EM_RESTART': '1', 13:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:44 INFO - 'PWD': '/builds/slave/test', 13:36:44 INFO - 'SHELL': '/bin/bash', 13:36:44 INFO - 'SHLVL': '1', 13:36:44 INFO - 'TERM': 'linux', 13:36:44 INFO - 'TMOUT': '86400', 13:36:44 INFO - 'USER': 'cltbld', 13:36:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:44 INFO - '_': '/tools/buildbot/bin/python'} 13:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:44 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 13:36:44 INFO - Cleaning up... 13:36:44 INFO - Return code: 0 13:36:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:44 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:44 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 13:36:44 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 13:36:44 INFO - Using env: {'DISPLAY': ':0', 13:36:44 INFO - 'HOME': '/home/cltbld', 13:36:44 INFO - 'LANG': 'en_US.UTF-8', 13:36:44 INFO - 'LANGUAGE': 'en_US:en', 13:36:44 INFO - 'LOGNAME': 'cltbld', 13:36:44 INFO - 'MAIL': '/var/mail/cltbld', 13:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:44 INFO - 'MOZ_NO_REMOTE': '1', 13:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:44 INFO - 'NO_EM_RESTART': '1', 13:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:44 INFO - 'PWD': '/builds/slave/test', 13:36:44 INFO - 'SHELL': '/bin/bash', 13:36:44 INFO - 'SHLVL': '1', 13:36:44 INFO - 'TERM': 'linux', 13:36:44 INFO - 'TMOUT': '86400', 13:36:44 INFO - 'USER': 'cltbld', 13:36:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:44 INFO - '_': '/tools/buildbot/bin/python'} 13:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:45 INFO - Downloading/unpacking psutil>=0.7.1 13:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:47 INFO - Installing collected packages: psutil 13:36:47 INFO - Running setup.py install for psutil 13:36:47 INFO - building 'psutil._psutil_linux' extension 13:36:47 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 13:36:47 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 13:36:47 INFO - building 'psutil._psutil_posix' extension 13:36:47 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 13:36:47 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 13:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:47 INFO - Successfully installed psutil 13:36:47 INFO - Cleaning up... 13:36:47 INFO - Return code: 0 13:36:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:36:47 INFO - Using env: {'DISPLAY': ':0', 13:36:47 INFO - 'HOME': '/home/cltbld', 13:36:47 INFO - 'LANG': 'en_US.UTF-8', 13:36:47 INFO - 'LANGUAGE': 'en_US:en', 13:36:47 INFO - 'LOGNAME': 'cltbld', 13:36:47 INFO - 'MAIL': '/var/mail/cltbld', 13:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:47 INFO - 'MOZ_NO_REMOTE': '1', 13:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:47 INFO - 'NO_EM_RESTART': '1', 13:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:47 INFO - 'PWD': '/builds/slave/test', 13:36:47 INFO - 'SHELL': '/bin/bash', 13:36:47 INFO - 'SHLVL': '1', 13:36:47 INFO - 'TERM': 'linux', 13:36:47 INFO - 'TMOUT': '86400', 13:36:47 INFO - 'USER': 'cltbld', 13:36:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:47 INFO - '_': '/tools/buildbot/bin/python'} 13:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:36:49 INFO - Installing collected packages: mozsystemmonitor 13:36:49 INFO - Running setup.py install for mozsystemmonitor 13:36:49 INFO - Successfully installed mozsystemmonitor 13:36:49 INFO - Cleaning up... 13:36:49 INFO - Return code: 0 13:36:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:49 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:49 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 13:36:49 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 13:36:49 INFO - Using env: {'DISPLAY': ':0', 13:36:49 INFO - 'HOME': '/home/cltbld', 13:36:49 INFO - 'LANG': 'en_US.UTF-8', 13:36:49 INFO - 'LANGUAGE': 'en_US:en', 13:36:49 INFO - 'LOGNAME': 'cltbld', 13:36:49 INFO - 'MAIL': '/var/mail/cltbld', 13:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:49 INFO - 'MOZ_NO_REMOTE': '1', 13:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:49 INFO - 'NO_EM_RESTART': '1', 13:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:49 INFO - 'PWD': '/builds/slave/test', 13:36:49 INFO - 'SHELL': '/bin/bash', 13:36:49 INFO - 'SHLVL': '1', 13:36:49 INFO - 'TERM': 'linux', 13:36:49 INFO - 'TMOUT': '86400', 13:36:49 INFO - 'USER': 'cltbld', 13:36:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:49 INFO - '_': '/tools/buildbot/bin/python'} 13:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 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 13:36:52 INFO - Downloading docopt-0.6.1.tar.gz 13:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:52 INFO - Running setup.py install for blobuploader 13:36:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:52 INFO - Running setup.py install for requests 13:36:53 INFO - Running setup.py install for docopt 13:36:53 INFO - Successfully installed blobuploader requests docopt 13:36:53 INFO - Cleaning up... 13:36:53 INFO - Return code: 0 13:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:53 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')]} 13:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:53 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')]} 13:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:53 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:53 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 13:36:53 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 13:36:53 INFO - Using env: {'DISPLAY': ':0', 13:36:53 INFO - 'HOME': '/home/cltbld', 13:36:53 INFO - 'LANG': 'en_US.UTF-8', 13:36:53 INFO - 'LANGUAGE': 'en_US:en', 13:36:53 INFO - 'LOGNAME': 'cltbld', 13:36:53 INFO - 'MAIL': '/var/mail/cltbld', 13:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:53 INFO - 'MOZ_NO_REMOTE': '1', 13:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:53 INFO - 'NO_EM_RESTART': '1', 13:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:53 INFO - 'PWD': '/builds/slave/test', 13:36:53 INFO - 'SHELL': '/bin/bash', 13:36:53 INFO - 'SHLVL': '1', 13:36:53 INFO - 'TERM': 'linux', 13:36:53 INFO - 'TMOUT': '86400', 13:36:53 INFO - 'USER': 'cltbld', 13:36:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:53 INFO - '_': '/tools/buildbot/bin/python'} 13:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:53 INFO - Running setup.py (path:/tmp/pip-U2H2R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:53 INFO - Running setup.py (path:/tmp/pip-FHwrRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:53 INFO - Running setup.py (path:/tmp/pip-IMfOw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:53 INFO - Running setup.py (path:/tmp/pip-fMA1xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:53 INFO - Running setup.py (path:/tmp/pip-Jyj1nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:53 INFO - Running setup.py (path:/tmp/pip-UP8hcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:53 INFO - Running setup.py (path:/tmp/pip-jlOh_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:54 INFO - Running setup.py (path:/tmp/pip-UOzZgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:54 INFO - Running setup.py (path:/tmp/pip-Uh0feH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:54 INFO - Running setup.py (path:/tmp/pip-8H5kxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:54 INFO - Running setup.py (path:/tmp/pip-11hmMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:54 INFO - Running setup.py (path:/tmp/pip-rlFbBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:54 INFO - Running setup.py (path:/tmp/pip-1dZX46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:54 INFO - Running setup.py (path:/tmp/pip-a9Lwdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:54 INFO - Running setup.py (path:/tmp/pip-qwRIe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:54 INFO - Running setup.py (path:/tmp/pip-Smx4BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:54 INFO - Running setup.py (path:/tmp/pip-yedcwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:54 INFO - Running setup.py install for manifestparser 13:36:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:54 INFO - Running setup.py install for mozcrash 13:36:54 INFO - Running setup.py install for mozdebug 13:36:55 INFO - Running setup.py install for mozdevice 13:36:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for mozfile 13:36:55 INFO - Running setup.py install for mozhttpd 13:36:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for mozinfo 13:36:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for mozInstall 13:36:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for mozleak 13:36:55 INFO - Running setup.py install for mozlog 13:36:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for moznetwork 13:36:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:55 INFO - Running setup.py install for mozprocess 13:36:56 INFO - Running setup.py install for mozprofile 13:36:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:56 INFO - Running setup.py install for mozrunner 13:36:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:56 INFO - Running setup.py install for mozscreenshot 13:36:56 INFO - Running setup.py install for moztest 13:36:56 INFO - Running setup.py install for mozversion 13:36:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:56 INFO - Cleaning up... 13:36:56 INFO - Return code: 0 13:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:56 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:36:56 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 13:36:56 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 13:36:56 INFO - Using env: {'DISPLAY': ':0', 13:36:56 INFO - 'HOME': '/home/cltbld', 13:36:56 INFO - 'LANG': 'en_US.UTF-8', 13:36:56 INFO - 'LANGUAGE': 'en_US:en', 13:36:56 INFO - 'LOGNAME': 'cltbld', 13:36:56 INFO - 'MAIL': '/var/mail/cltbld', 13:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:56 INFO - 'MOZ_NO_REMOTE': '1', 13:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:56 INFO - 'NO_EM_RESTART': '1', 13:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:56 INFO - 'PWD': '/builds/slave/test', 13:36:56 INFO - 'SHELL': '/bin/bash', 13:36:56 INFO - 'SHLVL': '1', 13:36:56 INFO - 'TERM': 'linux', 13:36:56 INFO - 'TMOUT': '86400', 13:36:56 INFO - 'USER': 'cltbld', 13:36:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:56 INFO - '_': '/tools/buildbot/bin/python'} 13:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:56 INFO - Running setup.py (path:/tmp/pip-64b_M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:56 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)) 13:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:56 INFO - Running setup.py (path:/tmp/pip-s188Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:56 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)) 13:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:56 INFO - Running setup.py (path:/tmp/pip-n1hlLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:56 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)) 13:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:57 INFO - Running setup.py (path:/tmp/pip-pN4ppF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:57 INFO - Running setup.py (path:/tmp/pip-poRw3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:57 INFO - Running setup.py (path:/tmp/pip-RwnBgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:57 INFO - Running setup.py (path:/tmp/pip-MY53K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:57 INFO - Running setup.py (path:/tmp/pip-UALN81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:57 INFO - Running setup.py (path:/tmp/pip-7n1Wma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:57 INFO - Running setup.py (path:/tmp/pip-S9GjLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:57 INFO - Running setup.py (path:/tmp/pip-n7gOVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:57 INFO - Running setup.py (path:/tmp/pip-kM32L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:57 INFO - Running setup.py (path:/tmp/pip-IUjgQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:57 INFO - Running setup.py (path:/tmp/pip-3yyYlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:57 INFO - Running setup.py (path:/tmp/pip-A_bMDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:57 INFO - Running setup.py (path:/tmp/pip-n4ZEie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:57 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)) 13:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:57 INFO - Running setup.py (path:/tmp/pip-agJxZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:58 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)) 13:36:58 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)) 13:36:58 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)) 13:36:58 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)) 13:36:58 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)) 13:36:58 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)) 13:36:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36:58 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 13:36:58 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 13:36:58 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 13:36:58 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 13:36:58 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 13:36:58 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 13:36:59 INFO - Downloading blessings-1.6.tar.gz 13:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:59 INFO - Installing collected packages: blessings 13:36:59 INFO - Running setup.py install for blessings 13:37:00 INFO - Successfully installed blessings 13:37:00 INFO - Cleaning up... 13:37:00 INFO - Return code: 0 13:37:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:00 INFO - Reading from file tmpfile_stdout 13:37:00 INFO - Current package versions: 13:37:00 INFO - argparse == 1.2.1 13:37:00 INFO - blessings == 1.6 13:37:00 INFO - blobuploader == 1.2.4 13:37:00 INFO - docopt == 0.6.1 13:37:00 INFO - manifestparser == 1.1 13:37:00 INFO - mozInstall == 1.12 13:37:00 INFO - mozcrash == 0.17 13:37:00 INFO - mozdebug == 0.1 13:37:00 INFO - mozdevice == 0.48 13:37:00 INFO - mozfile == 1.2 13:37:00 INFO - mozhttpd == 0.7 13:37:00 INFO - mozinfo == 0.9 13:37:00 INFO - mozleak == 0.1 13:37:00 INFO - mozlog == 3.1 13:37:00 INFO - moznetwork == 0.27 13:37:00 INFO - mozprocess == 0.22 13:37:00 INFO - mozprofile == 0.28 13:37:00 INFO - mozrunner == 6.11 13:37:00 INFO - mozscreenshot == 0.1 13:37:00 INFO - mozsystemmonitor == 0.0 13:37:00 INFO - moztest == 0.7 13:37:00 INFO - mozversion == 1.4 13:37:00 INFO - psutil == 3.1.1 13:37:00 INFO - requests == 1.2.3 13:37:00 INFO - wsgiref == 0.1.2 13:37:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:00 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:37:00 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 13:37:00 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 13:37:00 INFO - Using env: {'DISPLAY': ':0', 13:37:00 INFO - 'HOME': '/home/cltbld', 13:37:00 INFO - 'LANG': 'en_US.UTF-8', 13:37:00 INFO - 'LANGUAGE': 'en_US:en', 13:37:00 INFO - 'LOGNAME': 'cltbld', 13:37:00 INFO - 'MAIL': '/var/mail/cltbld', 13:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:00 INFO - 'MOZ_NO_REMOTE': '1', 13:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:00 INFO - 'NO_EM_RESTART': '1', 13:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:00 INFO - 'PWD': '/builds/slave/test', 13:37:00 INFO - 'SHELL': '/bin/bash', 13:37:00 INFO - 'SHLVL': '1', 13:37:00 INFO - 'TERM': 'linux', 13:37:00 INFO - 'TMOUT': '86400', 13:37:00 INFO - 'USER': 'cltbld', 13:37:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:00 INFO - '_': '/tools/buildbot/bin/python'} 13:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 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)) 13:37:00 INFO - Cleaning up... 13:37:00 INFO - Return code: 0 13:37:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37: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')]} 13:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:00 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:37:00 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 13:37:00 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 13:37:00 INFO - Using env: {'DISPLAY': ':0', 13:37:00 INFO - 'HOME': '/home/cltbld', 13:37:00 INFO - 'LANG': 'en_US.UTF-8', 13:37:00 INFO - 'LANGUAGE': 'en_US:en', 13:37:00 INFO - 'LOGNAME': 'cltbld', 13:37:00 INFO - 'MAIL': '/var/mail/cltbld', 13:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:00 INFO - 'MOZ_NO_REMOTE': '1', 13:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:00 INFO - 'NO_EM_RESTART': '1', 13:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:00 INFO - 'PWD': '/builds/slave/test', 13:37:00 INFO - 'SHELL': '/bin/bash', 13:37:00 INFO - 'SHLVL': '1', 13:37:00 INFO - 'TERM': 'linux', 13:37:00 INFO - 'TMOUT': '86400', 13:37:00 INFO - 'USER': 'cltbld', 13:37:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:00 INFO - '_': '/tools/buildbot/bin/python'} 13:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:00 INFO - Downloading/unpacking jsonschema 13:37:00 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 13:37:00 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 13:37:00 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 13:37:00 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 13:37:00 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 13:37:00 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 13:37:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:37:02 INFO - Downloading/unpacking functools32 (from jsonschema) 13:37:02 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 13:37:02 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 13:37:02 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 13:37:02 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 13:37:02 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 13:37:02 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 13:37:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:37:02 INFO - warning: no files found matching '*.txt' 13:37:02 INFO - no previously-included directories found matching 'build' 13:37:02 INFO - no previously-included directories found matching 'dist' 13:37:02 INFO - no previously-included directories found matching '.git*' 13:37:02 INFO - Installing collected packages: jsonschema, functools32 13:37:02 INFO - Running setup.py install for functools32 13:37:03 INFO - warning: no files found matching '*.txt' 13:37:03 INFO - no previously-included directories found matching 'build' 13:37:03 INFO - no previously-included directories found matching 'dist' 13:37:03 INFO - no previously-included directories found matching '.git*' 13:37:03 INFO - Successfully installed jsonschema functools32 13:37:03 INFO - Cleaning up... 13:37:03 INFO - Return code: 0 13:37:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:03 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 0x7fd49c1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, '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': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', '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 13:37:03 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 13:37:03 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 13:37:03 INFO - Using env: {'DISPLAY': ':0', 13:37:03 INFO - 'HOME': '/home/cltbld', 13:37:03 INFO - 'LANG': 'en_US.UTF-8', 13:37:03 INFO - 'LANGUAGE': 'en_US:en', 13:37:03 INFO - 'LOGNAME': 'cltbld', 13:37:03 INFO - 'MAIL': '/var/mail/cltbld', 13:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:03 INFO - 'MOZ_NO_REMOTE': '1', 13:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:03 INFO - 'NO_EM_RESTART': '1', 13:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:03 INFO - 'PWD': '/builds/slave/test', 13:37:03 INFO - 'SHELL': '/bin/bash', 13:37:03 INFO - 'SHLVL': '1', 13:37:03 INFO - 'TERM': 'linux', 13:37:03 INFO - 'TMOUT': '86400', 13:37:03 INFO - 'USER': 'cltbld', 13:37:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:03 INFO - '_': '/tools/buildbot/bin/python'} 13:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:03 INFO - Downloading/unpacking flake8 13:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:37:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:37:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:37:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 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 13:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:37:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:37:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:37:05 INFO - no previously-included directories found matching 'docs/_build' 13:37:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:37:06 INFO - Running setup.py install for pep8 13:37:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:37:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:37:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:37:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:37:06 INFO - no previously-included directories found matching 'docs/_build' 13:37:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:37:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:37:06 INFO - Cleaning up... 13:37:06 INFO - Return code: 0 13:37:06 INFO - Running post-action listener: _resource_record_post_action 13:37:06 INFO - Running post-action listener: _start_resource_monitoring 13:37:06 INFO - Starting resource monitoring. 13:37:06 INFO - ##### 13:37:06 INFO - ##### Running install step. 13:37:06 INFO - ##### 13:37:06 INFO - Running pre-action listener: _resource_record_pre_action 13:37:06 INFO - Running main action method: install 13:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:06 INFO - Reading from file tmpfile_stdout 13:37:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:37:06 INFO - Reading from file tmpfile_stdout 13:37:06 INFO - Output received: 13:37:06 INFO - Usage: mozinstall [options] installer 13:37:06 INFO - Options: 13:37:06 INFO - -h, --help show this help message and exit 13:37:06 INFO - -d DEST, --destination=DEST 13:37:06 INFO - Directory to install application into. [default: 13:37:06 INFO - "/builds/slave/test"] 13:37:06 INFO - --app=APP Application being installed. [default: firefox] 13:37:06 INFO - mkdir: /builds/slave/test/build/application 13:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:37:22 INFO - Reading from file tmpfile_stdout 13:37:22 INFO - Output received: 13:37:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:37:22 INFO - Running post-action listener: _resource_record_post_action 13:37:22 INFO - ##### 13:37:22 INFO - ##### Running run-tests step. 13:37:22 INFO - ##### 13:37:22 INFO - Running pre-action listener: _resource_record_pre_action 13:37:22 INFO - Running main action method: run_tests 13:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:37:22 INFO - Python 2.7.3 13:37:22 INFO - Return code: 0 13:37:22 INFO - grabbing minidump binary from tooltool 13:37: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')]} 13:37:22 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 0x1e66410>, '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 0x1e67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:37:22 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 13:37:22 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 13:37:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:37:22 INFO - Return code: 0 13:37:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:37:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:37:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:37:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:37:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:37:23 INFO - Return code: 0 13:37:23 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/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:37:23 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/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 13:37:23 INFO - Using env: {'DISPLAY': ':0', 13:37:23 INFO - 'HOME': '/home/cltbld', 13:37:23 INFO - 'LANG': 'en_US.UTF-8', 13:37:23 INFO - 'LANGUAGE': 'en_US:en', 13:37:23 INFO - 'LOGNAME': 'cltbld', 13:37:23 INFO - 'MAIL': '/var/mail/cltbld', 13:37:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:23 INFO - 'MOZ_NO_REMOTE': '1', 13:37:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:23 INFO - 'NO_EM_RESTART': '1', 13:37:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:23 INFO - 'PWD': '/builds/slave/test', 13:37:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:23 INFO - 'SHELL': '/bin/bash', 13:37:23 INFO - 'SHLVL': '1', 13:37:23 INFO - 'TERM': 'linux', 13:37:23 INFO - 'TMOUT': '86400', 13:37:23 INFO - 'USER': 'cltbld', 13:37:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587', 13:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:23 INFO - '_': '/tools/buildbot/bin/python'} 13:37:23 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/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 13:37:23 INFO - mozversion application_buildid: 20160505115951 13:37:23 INFO - mozversion application_changeset: e4e6e8589b76d09f1fa43186cbca61bdac430254 13:37:23 INFO - mozversion application_display_name: Nightly 13:37:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:37:23 INFO - mozversion application_name: Firefox 13:37:23 INFO - mozversion application_remotingname: firefox 13:37:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:37:23 INFO - mozversion application_vendor: Mozilla 13:37:23 INFO - mozversion application_version: 49.0a1 13:37:23 INFO - mozversion platform_buildid: 20160505115951 13:37:23 INFO - mozversion platform_changeset: e4e6e8589b76d09f1fa43186cbca61bdac430254 13:37:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:37:23 INFO - mozversion platform_version: 49.0a1 13:37:23 INFO - using testdate: 1462480643 13:37:23 INFO - actual date: 1462480643 13:37:23 INFO - starting webserver on 'localhost:33378' 13:37:23 INFO - SUITE-START | Running 2 tests 13:37:23 INFO - TEST-START | dromaeo_css 13:37:23 INFO - operating with platform_type : linux_ 13:37:23 INFO - Initialising browser for dromaeo_css test... 13:37:23 INFO - TEST-INFO | started process 9383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwzlK8/profile http://localhost:33378/getInfo.html) 13:37:28 INFO - PROCESS | 9383 | __metrics Screen width/height:1600/1200 13:37:28 INFO - PROCESS | 9383 | colorDepth:24 13:37:28 INFO - PROCESS | 9383 | Browser inner width/height: 1024/697 13:37:28 INFO - PROCESS | 9383 | __metrics 13:37:29 ERROR - PROCESS | 9383 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:37:31 INFO - TEST-INFO | 9383: exit 0 13:37:31 INFO - Browser initialized. 13:37:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:37:31 INFO - TEST-INFO | started process 9464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwzlK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:43 INFO - PROCESS | 9464 | RSS: Main: 154144768 13:37:43 INFO - PROCESS | 9464 | 13:38:34 INFO - PROCESS | 9464 | 1462480714696 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] 13:40:46 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33378/tests/dromaeo/cssquery-ext.html) 13:40:47 INFO - PROCESS | 9464 | RSS: Main: 264003584 13:40:47 INFO - PROCESS | 9464 | 13:43:50 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-ext.html (next: http://localhost:33378/tests/dromaeo/cssquery-jquery.html) 13:43:51 INFO - PROCESS | 9464 | RSS: Main: 238305280 13:43:51 INFO - PROCESS | 9464 | 13:46:53 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33378/tests/dromaeo/cssquery-mootools.html) 13:46:53 INFO - PROCESS | 9464 | RSS: Main: 240050176 13:46:53 INFO - PROCESS | 9464 | 13:49:56 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33378/tests/dromaeo/cssquery-prototype.html) 13:49:56 INFO - PROCESS | 9464 | RSS: Main: 233775104 13:49:56 INFO - PROCESS | 9464 | 13:52:59 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33378/tests/dromaeo/cssquery-yui.html) 13:53:00 INFO - PROCESS | 9464 | RSS: Main: 205713408 13:53:00 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | Cycle 1(1): loaded http://localhost:33378/tests/dromaeo/cssquery-yui.html (next: http://localhost:33378/tests/dromaeo/cssquery-dojo.html) 13:56:03 INFO - PROCESS | 9464 | RSS: Main: 269004800 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | __start_tp_report 13:56:03 INFO - PROCESS | 9464 | _x_x_mozilla_page_load 13:56:03 INFO - PROCESS | 9464 | _x_x_mozilla_page_load_details 13:56:03 INFO - PROCESS | 9464 | |i|pagename|runs| 13:56:03 INFO - PROCESS | 9464 | |0;dojo.html;2630.408158164413;2699.1362763915554;2729.2767416634583;2731.685856126545;2738.9452210955783;4635.58279754822;4702.741349225791;4710.222813235816;4768.332433459314;4785.258284965827;4712.222483290261;4770.618350531958;4820.373351464314;4835.782389792459;4847.684900481467;4305.956940430603;4307.978460107695;4338.826446942135;4398.406215160944;4418.425604671388;4376.256036473791;4418.712783669067;4496.55034496551;4535.750533720644;4537;4257;4391.165678521071;4479.664025198107;4498.3252512123445;4500.504944456107;4284.186004659105;4288.313869780851;4292.24885645014;4319.784010799479;4357;4284.464441944757;4341.956580434218;4346.239408103601;4347.7173983690955;4405.98662307671;4557.179707652621;4690.413698287714;4701.64737644678;4717.363155973968;4720.504347043579;5096.184610462308;5159.458256883011;5170.043541944752;5183.533481986639;5233.162693968985;5186.092433824066;5190.480951904817;5220.634555581111;5249.501297376743;5258.211268309746;4686.297055441711;4698.835540756126;4901.411830580318;4906.215005599087;4914.975425122851;5165.690058596496;5239.869003274948;5254.238135470336;5258.92111618326;5261;5001.374828146481;5045.117104506697;5046.84859454217;5052.646314757932;5055.570276526537;4996.925660982906;5027.522385373383;5077.213031980049;5082.898342033139;5088.618353623493;5041.773120209599;5042.571381432546;5045.2432135180015;5049;5091.694498330112;5026.949730502722;5030.320906677625;5032.672876263031;5038.294638750578;5077.289179514871;4210.031692710693;4247.532771395144;4255.276602977501;4349.717268377545;4397.648188144941;3737.8691745788765;3777.1690228149764;3799.3161230978135;3833.3291673956946;3887.475190849199;4386.8903277417685;4392.165488557164;4421.403110580095;4425.712328698624;4455.04216593434;4987.10232158215;5118.385793704705;5160.767765450564;5162.767675454614;5174.6377753557645;4378.277584198571;4422.314541246112;4426.18115648606;4429.756363400044;4445.310976798602;4665.533446655375;4673.275642275453;4676.111538807616;4712.434507859079;4716.268978308368;4631.861044168681;4836.177849765478;4872.610191184696;4883.462819089827;4883.8290659826735;5147.819826306061;5162.793488260578;5194.428612852659;5206.947930520798;5250.343707036621;4877.561019508261;4880.609551235963;4888.899997500534;4891.437484689164;4935.876603084952;4886.780094895667;5019.347484826949;5060.443351231435;5117.053345131163;5126.512981266774;5145.459726728789;5158.123119069842;5160.664556803796;5166.664166829294;5206.8958620828125;5021.372328458942;5023.748812559431;5024.673396229234;5025.84922452327;5078.822241221539;4870.512948705101;4915.852524424273;4947.307376967299;4950.727709975986;5009.924851127309;4885.511448855086;4888.6577939543895;4902.240152776325;4953.331300274417;4957.504249575014;5005.099082165245;5007;5010.048090862724;5051.217061355495;5056.974715126401;4779.139754844023;4836.202026665561;4885.438174609823;4898.314236007033;4899.363082799213 13:56:03 INFO - PROCESS | 9464 | |1;ext.html;562.6314763829693;602.0637908052977;602.9668368239745;604.9939500604993;610.2524407600688;27385.726142738567;41427.55003574872;42785.78607106968;42874.785626071905;42904.356434653426;42011;42436.15127697452;42437.151256974845;42555.78722106385;42600.360994585026;8043.436959412828;8146.26683598476;8170.918290817105;8173.346132309431;8173.754787356389;8037.839243215132;8134.023917129953;8169.591520423985;8171.223733745284;8173.79565510864;8149.348052155813;8230.2592766651;8231.053428855668;8232.300254478376;8238.546879921601;8157;8167.836643267161;8185.3451723861945;8218.096009438957;8220.219079187467;8061.2744852963515;8121.30968867647;8125.268725814646;8137.2676459118375;8138;39666;39676.40485392721;39821;39832.60167398347;40118.59881401178;3154.747620190379;3394.592648882125;3625.782453052825;3850.441685955521;3928.253631809947;29625;29886;30081.548776768366;30262.84868575665;31428.37143257122;2763.553766761644;2930.164903002634;2952.9409411811857;2966.362232120083;3013.03582853487;204604;255547.05585304426;256932;258309.70845145843;258395;56950.43049569534;59108;59534.40465595289;59573;59616.70191649014;62971;65632.67183664147;65644.67177664081;71601;71775;15824;16114;16117;16127.435539756052;16132.919335403249;12002.819957700642;12069.094817888517;12104.273743575413;12104.697382565506;12111;19613.803861961198;19692.50768730793;19732.60534789296;19747.50631234202;19748.901255493918;7110.431165506747;7132.786016419515;7199.532030418006;7326.633668316669;7458.85082298351;840.5335039053261;919.8804155459882;930.6417029443713;972.562346943864;995.8356871116184;27636.309092272855;29175.64480084775;29256.853715731286;29440.411191776046;29736.40527189444;968.4576637083256;1039.740064983754;1087.3475914451424;1099.120703437263;1125.1055410948316;15699;15739.527814165593;15824.60438489047;15825.920870395574;16033.919830401006;348057;348066;350254;351382;351402;52769.47230527645;53177.202341964905;53360.73319633377;53421.7328913353;53564.196537051976;1162.511745067074;1256.1269917407496;1298.3962457457328;1300.2978391668394;1306.137948953686;28325.291867703472;29180;29576.556351655174;29758.553621696126;30022.69977300199;44050.33924491071;44476.77761611301;44616;44675.553244468436;44683.77658111689;265083;265384;266023;266147;267852;20988.790112098683;26419.339516512242;26468.205953821416;27534.311642209104;27610.44779104447;43628.781856090514;43735.78132109319;43882.341764872916;44717.329240060775;45108.32337514874;37138;37858.43212351872;37893.24213515659;38389;38987;36067.27865442729;37630.62369376271;37773;37877.43183852299;39711;38024.61975380211;38084.619153808104;38583.22833543257;38592;38842.6115738839;33070;34161.48757768685;34385.484217737256;34639;34935;25323.620145698198;26331.473370532865;26430;26439.33901652474;26721.465570688866 13:56:03 INFO - PROCESS | 9464 | |2;jquery.html;375.7764130342446;378.732993239766;384.8353014294591;395.24508189358295;396.1996766531606;15644.765328520067;16712.83287167128;17689.911550442244;17831.55421114473;17868.463946081607;14806.925965370185;15211.391544338214;15346.462873799419;15439.536813895602;15553;5037.84886453406;5129.589632829365;5142.434332223453;5151.201563757623;5224.216367544861;3643.271345730851;5578.191162281467;5848.64908105515;5869.794557190499;5968.343482216953;5901.822945311647;6019.909701354483;6020.45815876571;6040.426159514839;6054.273487181545;5849.444302791228;5976.820695379146;6010.459058684717;6017.518598512131;6018.337982821908;3298.208429976812;3471.5139880416764;3485.7734247273847;3503.8248087595516;4926.285688575136;19328.903355483275;19755.11102000399;20504.897475512676;20542.17831286747;20550.38348849537;1998.2206939293542;2029.756429228502;2033.6949457581482;2264.0377839418347;2302.481941563135;12752.234865908074;12904.935475322658;13122.803157952638;13128.409221585052;13177.86822131776;1706.1980868991554;1777.1824960518177;1843.1337271482382;1851.3242666426793;1878.2487005197893;63759.04361434582;63790.68104659493;64504;65163;65721.67139164322;9281.350305478552;9394.792223827395;9439.52802359893;9556.76108097303;9822.508874556386;12946;13111.409986550438;13126.803097953538;13130.671733206555;13143.934280328729;7491.8501629967095;7562.697492100365;7596.772096837104;7709.761900002012;7790;7426.220246874109;7494.925050749532;7515.887261691079;7586.431017673696;7622.504537205064;5984.371640977722;6109.877802443926;6191.133241346215;6194.101855230966;6226.470749986212;1561.8360072192484;1660.3856573068042;1765.9823401765818;1786.8749187557007;1835.586992926581;887.9378443508892;934.4113208678489;963.1091240602415;991.2020823237364;1037.870266216723;17043.488695339158;17058.147092645566;17197;17226.655466890592;17578.208980595904;932.8554074118523;938.8357037518407;942.495764765847;955.2214944819949;1010.5604062232952;9873.308868379288;10058.34620749649;10202.540885660163;10221.386716797017;10352.430616316175;373244;383290;386922;388157;389489;40115;63849;66256.33743662502;66569.75013396374;67133.66433167802;968.4818622037176;994.1947022911465;999.4003597841237;1020.0309705779391;1025.5487585462372;15154.16652084146;15259.847401526287;15348.30932608013;15413.922930385725;15631;31165;31384.68615313909;32069.67930320667;32101.197470063435;32731.836340818143;40418.39372409475;41516.16967660569;41835.581644184385;42095.789521053426;42313.365299519915;7432.293932076444;7774.339181169664;7780.377569794289;7796.532208067534;7851.842963140591;9949.950250248703;10880.347179169275;11141.72145696364;11475.196736228718;11534.192606517463;9629.085236902483;9897.406155630686;10045.849312260469;10062.345947513388;10339.844902326622;9602.375845570015;9746.85379719319;9887.357321774061;9897.950510247403;9909.108180263811;9861.556229969525;9978.401295922267;10001.499925003865;10002.099811017044;10147.84778228342;7419.962900185465;7431.219721929119;7546.698132074655;7609.581473019037;7733.8839917400155;9629.422234665943;9713;9799.042679697495;9836.114749672564;10151.7462063449 13:56:03 INFO - PROCESS | 9464 | |3;mootools.html;1292.211750831993;1500.5348342013974;1521.4826958833999;1676.212180275271;1827.2782251010842;6596.406323430891;7314.414846812256;7526.849463010736;7552;7714.498557593766;7281.854362912739;7429.6285185740635;7437.25627437256;7437.702491900331;7463.738769143081;2176.4450065233345;2202.6695995600626;2205.658122990931;2212.7676593957644;2213.457702862801;2140.625390556654;2176.249194028058;2177.4991751897073;2178.1287485005964;2180.062573093569;2099.9265025724103;2107.388857231401;2125.3836387447623;2128.8084072433476;2131.232756207764;2150.9784902150936;2154.127578330763;2155;2156.956860862782;2160.5786871560053;2085.061722225005;2143.3141394753684;2144.8713077215416;2145.2384403536676;2145.410012246629;7421.294976977232;7530.246975302426;7580.128285247157;7586.355159811367;7588.658510366991;4477.194105061088;4628.352030715702;4642.814287428499;4643.558861908114;4656.092062047902;2875.62616859809;2877.5827505011657;2900.76793856491;2901.680815110336;2943.1611990582796;947.3984020147187;951.267524006518;958.1999030809283;974.2985050763439;988.0810845913297;10310.896891031143;10323.793524129474;10361.171106311476;10454.268201225917;10464.947675261652;3745.662890339828;3867.806609669505;3924.0582260257333;3926.489556357655;3997.2804895119157;8273.710420135267;8368.707095251637;8370.623321950527;8387.62255698495;8415.45299555527;4438.312061630452;4448.199324121624;4460.955390446119;4466.888327791831;4475.239209334421;3498.440249560109;3984.8406063757707;4057.229126465962;4109.856155034559;4176.4570605821045;3379.9155021124175;3413.4367829308385;3480.129967508123;3500.5974312953826;3508.122969257686;1053.1574740207802;1063.7500187455942;1070.2775626452114;1071.1698433713777;1079.611339917629;905.158202871336;915.5651065743851;918.3855436010182;929.9860502092474;939.4973689076311;5507.311586051744;5526.861828454321;5574.804881829116;5630.436956304418;5700.686462244616;886.9201771840566;887.8401887660283;891.9063498332712;902.444996327254;959.8176346494143;3826.330392181357;3913.6477717005605;3953.8616148435244;3956.347202711578;4022.3966405039478;8967.058458861857;9082.86375704365;9263.814723705487;9274.350795444388;9411.200047995997;9237.3533852631;9292.53537323131;9345.719628411158;9395.90604093964;9401.24790016797;7209.315115064061;7244.891326630105;7296.854062918712;7340.486165968331;7376.114866216089;5490.231367608618;5497.092979658311;5529.419410961952;5536.557075434036;5684.9431505684415;7915.327197188303;8080.393970452122;8105.392095592736;8745.868811967954;8860.822783544421;8370.330373569977;8424.326053915795;8436.11420800807;8459.365547583833;8467.49195048299;6056.3035250946705;6465.741370345321;6496;6660.766873159416;6752.763653272112;7374.1151061872915;7514.286142816423;7539.095308562788;7561.7353392633195;7591.962040189764;6611.867762644624;6837.35045170708;6837.965810170917;6986.231514533499;6997.160340759141;6493.935060649333;6542.149520562297;6583.637899915359;6622.867542649024;6690.59856408617;6359.745610175726;6375.808725738235;6411.038344248213;6418.743250269937;6425.935740642533;4742.952570474389;4874.975625121851;4876.975615122044;4880.048390563806;4940.456549779449;4699.953000469952;4794.760261986817;4829;4894.119058569349;4945.085159245551 13:56:03 INFO - PROCESS | 9464 | |4;prototype.html;290.1310574828389;293.85307346326834;296.2283252128206;297.4556561492469;303.6705174885249;4745.962583946272;4786.401699787527;4796.625670293201;4802.03959208158;4815.277708343741;4698.130845793522;4744.620430365571;4755.595774359175;4758.619310455164;4759.904801903968;3560.679538841497;3671.733252028046;3678.9448158277514;3691.3724666806706;3694;3649.59854416014;3678.411454167334;3809.7904615246152;3822.3310920588924;3840.1551658635194;3724.255148970217;3761.7742935423826;3773.2264885698364;3774.113083425407;3783.2811765764554;3608.657177568127;3755.511783468159;3774.3772277574167;3775.4903088083033;3782.583915769263;3137.7646676499353;3230.0471360948577;3234.611846578402;3237.7211001654214;3243.8702451901895;4472.709273897186;4551.226291530448;4613.777349002517;4641.976790116061;4644.9535504644855;4306.676999225071;4319.611234988866;4328.307470804656;4329.545397733255;4329.740215587075;4866.780835556969;5001.999600079962;5015.899682006376;5044;5050.621203409759;3613.981930090359;3617.8422904670515;3629.4555816627453;3641.7086633069557;3654.634536546324;5188.92216616751;5205.8958820823755;5219.347581552268;5224.92162617561;5227.47725227478;3647.2705458907794;3733.962660373416;3737.458068580095;3748.5755412943454;3774.3206222879594;3758.624137586274;3770.3024940386117;3788.6969042477085;3793.829277682511;3794.2601192767147;4254.191703576311;4256.425382573375;4265.125649241898;4267.786610669516;4285.5928686774705;4990.30135780991;4991.425986011583;5001;5018.365358186981;5022.874428139326;1243.527361994341;1248.5942068827485;1283.2621242785435;1294.3916359311297;1297.357807885084;879.3624622149018;879.8254330468895;894.8344556256983;899.7750562359411;903.7198468474794;4246.511651160156;4307.234034046026;4313.956860431418;4317.352397140454;4347.152305300436;5024.472430394829;5052.696838189647;5053.8736531587;5099.643024988215;5123.462036486189;4263.786810659517;4340.197063543254;4364.672649551297;4366.978165109154;4378.60592546666;2534.379077126116;2544.727636181909;2656.296081538394;2671.7061123276426;2706.391062011071;4791.976040119777;4897.216445368724;4915.287283343967;4923.507649235119;4934.235193545006;5292.52367286946;5298.81454149103;5301.496357845998;5309.097453432925;5322.866928326823;4781.808727650925;4871.196252618278;4893.681910675866;4902.926456103161;4908.337374454403;5153.268767553202;5168.819091331786;5170.741462926914;5174.948250517597;5175.273802861933;4986.80052797884;5084.567811735896;5091.261767043832;5093.516115968977;5117.257997590403;4682.836100736458;4820.542048505386;4838.588719958843;4877.853664390074;4915.321149973344;3730.3285408626707;3753.436984452354;3753.943690844585;3761.586225515246;3761.6614504693616;5098.719570423514;5156.215643552439;5176.948230517797;5178.275041494269;5191.740412979411;4736.8105275788585;5004.499550044967;5014.398272207212;5028.723420211923;5043.974780126223;4962.379702537183;4996.950030499648;5024.698518088926;5025.894303253279;5034.59723222134;4917.459079501324;4932.605391568738;4945.4807245238735;4964.67729597575;4991.28149528589;4894.51054894522;5046.697198168122;5067.366579177603;5078.644494885322;5104.157813960804;4968.205087186033;4975.353204083591;4990.401151861654;4998.350214472095;5002.549770520671 13:56:03 INFO - PROCESS | 9464 | |5;yui.html;707.6992278281732;744.2631794523422;779.2597032818824;793.3534169651737;807.652709334986;11283.153763467732;11326.32042077475;11423.771524569504;11452.484638191281;11467.59863404781;12235.755284894296;12297.877021229786;12320.383980800969;12348.691282717915;12369.257844529335;670.9630970296631;827.1273806134526;846.8052347959973;861.8233262181269;874.33113668044;870.9129087091272;870.921617054465;874.1695389380083;874.2568816505983;874.6282829797311;925.4447331601019;927.7773334399762;928.8003079337941;929.2380248196481;929.6281487405058;704.7075463682565;724.2142275630947;724.9601271930042;731.5391303478827;924.3621900888365;655.1941112431688;678.3691167214489;678.4131726056975;678.8608335291253;679.4564348521212;11730.88269117315;11739.060875130055;11739.471723772365;11742.70643233926;11758.823617645741;11696.590619328283;12033.338166400845;12142.392880355947;12216.877831221664;12244.204126731735;10810.675704723522;10819.404932728698;10938.179636527293;10994.505247263893;11104.056155226815;4079.0822065035427;4079.1433798902267;4111.239420707178;4120.690948178899;4266.189424009459;41972.79013604912;42011;42013.78993105046;42103.36844947328;42314;9268.25853931684;9589.041095890356;9642.95178524117;9705.641210230573;9912.504374781232;15485.767713484307;15705.764413533807;15719.292631831595;15747.763783543256;15767.605809854616;6364.1408409865;6554.80335589933;6639.734410623618;6748.358905903931;6868.141482314711;3710.8330125144435;3743.5133432654125;3783.981080094582;3791.4881490998914;3855.749376290532;2650.178444682116;2724.7547720705234;2738.602902579115;2739.0413355325477;2745.23133522614;507.1226777674644;509.9082165210224;528.1259515501774;532.1060618161448;532.4010488200774;557.7127779193719;572.4046991129262;577.3014652270799;582.1326223926404;597.3011576455557;6836.4530837532875;6869.293978209945;6911.5853048817235;6949.895751563629;7099.3965512930945;490.7521701540699;499.0144464682296;537.5189205660912;567.5459632294148;568.0882184094469;3254.1286321510943;3360.9663903361143;3388.745844061705;3390.288039511681;3457.239407330383;48364.27453588199;49602;49750;49796;49983.500164998615;45322.77338613286;46498.5350146501;46622.300665490046;46642.30036549454;47590;41979.79010104991;43343.78328108403;43950.12099758051;44249.690037195745;44817.10365792666;8122.390820688353;8370.330373570221;8383.958080209804;8410.243078122998;8477.872831907403;29406.411871762873;29656;29944.101676949726;30893;31084.68915310818;34778.82610586931;35909;38318.80840595891;38570.80714596409;38769.80615096907;9569.856452153363;9689.903100969183;10787.406692631666;10845.511951962022;11750.764984700087;10752.462376881282;11018.779624407627;11045.392503412068;11534.307941523535;11895.167338286583;11018.449077546251;11044.668659940215;11053.28153670009;11206.7758644825;11212.103031757602;10822.67531974042;10910.2362834604;10983.121350291798;11375.829362559734;11568.07455403549;10343.586256549654;10676.092532134855;10814.891851081704;11195.944020279847;11214;8860.291176705978;8969.416987896027;9120.270378369847;9293.581788819654;9441.52792360393;8938.955305223431;9162.908370916472;9263.86104208424;9308.627654893728;9387.342885998189 13:56:03 INFO - PROCESS | 9464 | __end_tp_report 13:56:03 INFO - PROCESS | 9464 | __start_cc_report 13:56:03 INFO - PROCESS | 9464 | _x_x_mozilla_cycle_collect,998 13:56:03 INFO - PROCESS | 9464 | __end_cc_report 13:56:03 INFO - PROCESS | 9464 | __startTimestamp1462481763275__endTimestamp 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | ------- Summary: start ------- 13:56:03 INFO - PROCESS | 9464 | Number of tests: 6 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#0] dojo.html Cycles:165 Average:4729.83 Median:4885.44 stddev:497.66 (10.2%) stddev-sans-first:471.14 13:56:03 INFO - PROCESS | 9464 | Values: 2630.4 2699.1 2729.3 2731.7 2738.9 4635.6 4702.7 4710.2 4768.3 4785.3 4712.2 4770.6 4820.4 4835.8 4847.7 4306.0 4308.0 4338.8 4398.4 4418.4 4376.3 4418.7 4496.6 4535.8 4537.0 4257.0 4391.2 4479.7 4498.3 4500.5 4284.2 4288.3 4292.2 4319.8 4357.0 4284.5 4342.0 4346.2 4347.7 4406.0 4557.2 4690.4 4701.6 4717.4 4720.5 5096.2 5159.5 5170.0 5183.5 5233.2 5186.1 5190.5 5220.6 5249.5 5258.2 4686.3 4698.8 4901.4 4906.2 4915.0 5165.7 5239.9 5254.2 5258.9 5261.0 5001.4 5045.1 5046.8 5052.6 5055.6 4996.9 5027.5 5077.2 5082.9 5088.6 5041.8 5042.6 5045.2 5049.0 5091.7 5026.9 5030.3 5032.7 5038.3 5077.3 4210.0 4247.5 4255.3 4349.7 4397.6 3737.9 3777.2 3799.3 3833.3 3887.5 4386.9 4392.2 4421.4 4425.7 4455.0 4987.1 5118.4 5160.8 5162.8 5174.6 4378.3 4422.3 4426.2 4429.8 4445.3 4665.5 4673.3 4676.1 4712.4 4716.3 4631.9 4836.2 4872.6 4883.5 4883.8 5147.8 5162.8 5194.4 5206.9 5250.3 4877.6 4880.6 4888.9 4891.4 4935.9 4886.8 5019.3 5060.4 5117.1 5126.5 5145.5 5158.1 5160.7 5166.7 5206.9 5021.4 5023.7 5024.7 5025.8 5078.8 4870.5 4915.9 4947.3 4950.7 5009.9 4885.5 4888.7 4902.2 4953.3 4957.5 5005.1 5007.0 5010.0 5051.2 5057.0 4779.1 4836.2 4885.4 4898.3 4899.4 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#1] ext.html Cycles:180 Average:46227.86 Median:38054.62 stddev:76290.32 (200.5%) stddev-sans-first:76427.28 13:56:03 INFO - PROCESS | 9464 | Values: 562.6 602.1 603.0 605.0 610.3 27385.7 41427.6 42785.8 42874.8 42904.4 42011.0 42436.2 42437.2 42555.8 42600.4 8043.4 8146.3 8170.9 8173.3 8173.8 8037.8 8134.0 8169.6 8171.2 8173.8 8149.3 8230.3 8231.1 8232.3 8238.5 8157.0 8167.8 8185.3 8218.1 8220.2 8061.3 8121.3 8125.3 8137.3 8138.0 39666.0 39676.4 39821.0 39832.6 40118.6 3154.7 3394.6 3625.8 3850.4 3928.3 29625.0 29886.0 30081.5 30262.8 31428.4 2763.6 2930.2 2952.9 2966.4 3013.0 204604.0 255547.1 256932.0 258309.7 258395.0 56950.4 59108.0 59534.4 59573.0 59616.7 62971.0 65632.7 65644.7 71601.0 71775.0 15824.0 16114.0 16117.0 16127.4 16132.9 12002.8 12069.1 12104.3 12104.7 12111.0 19613.8 19692.5 19732.6 19747.5 19748.9 7110.4 7132.8 7199.5 7326.6 7458.9 840.5 919.9 930.6 972.6 995.8 27636.3 29175.6 29256.9 29440.4 29736.4 968.5 1039.7 1087.3 1099.1 1125.1 15699.0 15739.5 15824.6 15825.9 16033.9 348057.0 348066.0 350254.0 351382.0 351402.0 52769.5 53177.2 53360.7 53421.7 53564.2 1162.5 1256.1 1298.4 1300.3 1306.1 28325.3 29180.0 29576.6 29758.6 30022.7 44050.3 44476.8 44616.0 44675.6 44683.8 265083.0 265384.0 266023.0 266147.0 267852.0 20988.8 26419.3 26468.2 27534.3 27610.4 43628.8 43735.8 43882.3 44717.3 45108.3 37138.0 37858.4 37893.2 38389.0 38987.0 36067.3 37630.6 37773.0 37877.4 39711.0 38024.6 38084.6 38583.2 38592.0 38842.6 33070.0 34161.5 34385.5 34639.0 34935.0 25323.6 26331.5 26430.0 26439.3 26721.5 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#2] jquery.html Cycles:180 Average:23233.65 Median:40967.28 stddev:62956.26 (153.7%) stddev-sans-first:63109.47 13:56:03 INFO - PROCESS | 9464 | Values: 375.8 378.7 384.8 395.2 396.2 15644.8 16712.8 17689.9 17831.6 17868.5 14806.9 15211.4 15346.5 15439.5 15553.0 5037.8 5129.6 5142.4 5151.2 5224.2 3643.3 5578.2 5848.6 5869.8 5968.3 5901.8 6019.9 6020.5 6040.4 6054.3 5849.4 5976.8 6010.5 6017.5 6018.3 3298.2 3471.5 3485.8 3503.8 4926.3 19328.9 19755.1 20504.9 20542.2 20550.4 1998.2 2029.8 2033.7 2264.0 2302.5 12752.2 12904.9 13122.8 13128.4 13177.9 1706.2 1777.2 1843.1 1851.3 1878.2 63759.0 63790.7 64504.0 65163.0 65721.7 9281.4 9394.8 9439.5 9556.8 9822.5 12946.0 13111.4 13126.8 13130.7 13143.9 7491.9 7562.7 7596.8 7709.8 7790.0 7426.2 7494.9 7515.9 7586.4 7622.5 5984.4 6109.9 6191.1 6194.1 6226.5 1561.8 1660.4 1766.0 1786.9 1835.6 887.9 934.4 963.1 991.2 1037.9 17043.5 17058.1 17197.0 17226.7 17578.2 932.9 938.8 942.5 955.2 1010.6 9873.3 10058.3 10202.5 10221.4 10352.4 373244.0 383290.0 386922.0 388157.0 389489.0 40115.0 63849.0 66256.3 66569.8 67133.7 968.5 994.2 999.4 1020.0 1025.5 15154.2 15259.8 15348.3 15413.9 15631.0 31165.0 31384.7 32069.7 32101.2 32731.8 40418.4 41516.2 41835.6 42095.8 42313.4 7432.3 7774.3 7780.4 7796.5 7851.8 9950.0 10880.3 11141.7 11475.2 11534.2 9629.1 9897.4 10045.8 10062.3 10339.8 9602.4 9746.9 9887.4 9898.0 9909.1 9861.6 9978.4 10001.5 10002.1 10147.8 7420.0 7431.2 7546.7 7609.6 7733.9 9629.4 9713.0 9799.0 9836.1 10151.7 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#3] mootools.html Cycles:180 Average:5048.06 Median:5555.68 stddev:2737.97 (49.3%) stddev-sans-first:2731.10 13:56:03 INFO - PROCESS | 9464 | Values: 1292.2 1500.5 1521.5 1676.2 1827.3 6596.4 7314.4 7526.8 7552.0 7714.5 7281.9 7429.6 7437.3 7437.7 7463.7 2176.4 2202.7 2205.7 2212.8 2213.5 2140.6 2176.2 2177.5 2178.1 2180.1 2099.9 2107.4 2125.4 2128.8 2131.2 2151.0 2154.1 2155.0 2157.0 2160.6 2085.1 2143.3 2144.9 2145.2 2145.4 7421.3 7530.2 7580.1 7586.4 7588.7 4477.2 4628.4 4642.8 4643.6 4656.1 2875.6 2877.6 2900.8 2901.7 2943.2 947.4 951.3 958.2 974.3 988.1 10310.9 10323.8 10361.2 10454.3 10464.9 3745.7 3867.8 3924.1 3926.5 3997.3 8273.7 8368.7 8370.6 8387.6 8415.5 4438.3 4448.2 4461.0 4466.9 4475.2 3498.4 3984.8 4057.2 4109.9 4176.5 3379.9 3413.4 3480.1 3500.6 3508.1 1053.2 1063.8 1070.3 1071.2 1079.6 905.2 915.6 918.4 930.0 939.5 5507.3 5526.9 5574.8 5630.4 5700.7 886.9 887.8 891.9 902.4 959.8 3826.3 3913.6 3953.9 3956.3 4022.4 8967.1 9082.9 9263.8 9274.4 9411.2 9237.4 9292.5 9345.7 9395.9 9401.2 7209.3 7244.9 7296.9 7340.5 7376.1 5490.2 5497.1 5529.4 5536.6 5684.9 7915.3 8080.4 8105.4 8745.9 8860.8 8370.3 8424.3 8436.1 8459.4 8467.5 6056.3 6465.7 6496.0 6660.8 6752.8 7374.1 7514.3 7539.1 7561.7 7592.0 6611.9 6837.4 6838.0 6986.2 6997.2 6493.9 6542.1 6583.6 6622.9 6690.6 6359.7 6375.8 6411.0 6418.7 6425.9 4743.0 4875.0 4877.0 4880.0 4940.5 4700.0 4794.8 4829.0 4894.1 4945.1 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#4] prototype.html Cycles:180 Average:4166.83 Median:4757.11 stddev:1208.12 (25.4%) stddev-sans-first:1175.94 13:56:03 INFO - PROCESS | 9464 | Values: 290.1 293.9 296.2 297.5 303.7 4746.0 4786.4 4796.6 4802.0 4815.3 4698.1 4744.6 4755.6 4758.6 4759.9 3560.7 3671.7 3678.9 3691.4 3694.0 3649.6 3678.4 3809.8 3822.3 3840.2 3724.3 3761.8 3773.2 3774.1 3783.3 3608.7 3755.5 3774.4 3775.5 3782.6 3137.8 3230.0 3234.6 3237.7 3243.9 4472.7 4551.2 4613.8 4642.0 4645.0 4306.7 4319.6 4328.3 4329.5 4329.7 4866.8 5002.0 5015.9 5044.0 5050.6 3614.0 3617.8 3629.5 3641.7 3654.6 5188.9 5205.9 5219.3 5224.9 5227.5 3647.3 3734.0 3737.5 3748.6 3774.3 3758.6 3770.3 3788.7 3793.8 3794.3 4254.2 4256.4 4265.1 4267.8 4285.6 4990.3 4991.4 5001.0 5018.4 5022.9 1243.5 1248.6 1283.3 1294.4 1297.4 879.4 879.8 894.8 899.8 903.7 4246.5 4307.2 4314.0 4317.4 4347.2 5024.5 5052.7 5053.9 5099.6 5123.5 4263.8 4340.2 4364.7 4367.0 4378.6 2534.4 2544.7 2656.3 2671.7 2706.4 4792.0 4897.2 4915.3 4923.5 4934.2 5292.5 5298.8 5301.5 5309.1 5322.9 4781.8 4871.2 4893.7 4902.9 4908.3 5153.3 5168.8 5170.7 5174.9 5175.3 4986.8 5084.6 5091.3 5093.5 5117.3 4682.8 4820.5 4838.6 4877.9 4915.3 3730.3 3753.4 3753.9 3761.6 3761.7 5098.7 5156.2 5176.9 5178.3 5191.7 4736.8 5004.5 5014.4 5028.7 5044.0 4962.4 4997.0 5024.7 5025.9 5034.6 4917.5 4932.6 4945.5 4964.7 4991.3 4894.5 5046.7 5067.4 5078.6 5104.2 4968.2 4975.4 4990.4 4998.4 5002.5 13:56:03 INFO - PROCESS | 9464 | 13:56:03 INFO - PROCESS | 9464 | [#5] yui.html Cycles:180 Average:12460.96 Median:44099.91 stddev:14004.42 (31.8%) stddev-sans-first:14015.89 13:56:03 INFO - PROCESS | 9464 | Values: 707.7 744.3 779.3 793.4 807.7 11283.2 11326.3 11423.8 11452.5 11467.6 12235.8 12297.9 12320.4 12348.7 12369.3 671.0 827.1 846.8 861.8 874.3 870.9 870.9 874.2 874.3 874.6 925.4 927.8 928.8 929.2 929.6 704.7 724.2 725.0 731.5 924.4 655.2 678.4 678.4 678.9 679.5 11730.9 11739.1 11739.5 11742.7 11758.8 11696.6 12033.3 12142.4 12216.9 12244.2 10810.7 10819.4 10938.2 10994.5 11104.1 4079.1 4079.1 4111.2 4120.7 4266.2 41972.8 42011.0 42013.8 42103.4 42314.0 9268.3 9589.0 9643.0 9705.6 9912.5 15485.8 15705.8 15719.3 15747.8 15767.6 6364.1 6554.8 6639.7 6748.4 6868.1 3710.8 3743.5 3784.0 3791.5 3855.7 2650.2 2724.8 2738.6 2739.0 2745.2 507.1 509.9 528.1 532.1 532.4 557.7 572.4 577.3 582.1 597.3 6836.5 6869.3 6911.6 6949.9 7099.4 490.8 499.0 537.5 567.5 568.1 3254.1 3361.0 3388.7 3390.3 3457.2 48364.3 49602.0 49750.0 49796.0 49983.5 45322.8 46498.5 46622.3 46642.3 47590.0 41979.8 43343.8 43950.1 44249.7 44817.1 8122.4 8370.3 8384.0 8410.2 8477.9 29406.4 29656.0 29944.1 30893.0 31084.7 34778.8 35909.0 38318.8 38570.8 38769.8 9569.9 9689.9 10787.4 10845.5 11750.8 10752.5 11018.8 11045.4 11534.3 11895.2 11018.4 11044.7 11053.3 11206.8 11212.1 10822.7 10910.2 10983.1 11375.8 11568.1 10343.6 10676.1 10814.9 11195.9 11214.0 8860.3 8969.4 9120.3 9293.6 9441.5 8939.0 9162.9 9263.9 9308.6 9387.3 13:56:03 INFO - PROCESS | 9464 | -------- Summary: end -------- 13:56:03 INFO - PROCESS | 9464 | 13:56:04 INFO - TEST-INFO | 9464: exit 0 13:56:04 INFO - TEST-OK | dromaeo_css | took 1120656ms 13:56:04 INFO - TEST-START | kraken 13:56:04 INFO - operating with platform_type : linux_ 13:56:04 INFO - Initialising browser for kraken test... 13:56:04 INFO - TEST-INFO | started process 9640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeS6LGk/profile http://localhost:33378/getInfo.html) 13:56:08 INFO - PROCESS | 9640 | __metrics Screen width/height:1600/1200 13:56:08 INFO - PROCESS | 9640 | colorDepth:24 13:56:08 INFO - PROCESS | 9640 | Browser inner width/height: 1024/697 13:56:08 INFO - PROCESS | 9640 | __metrics 13:56:10 ERROR - PROCESS | 9640 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:56:11 INFO - TEST-INFO | 9640: exit 0 13:56:11 INFO - Browser initialized. 13:56:11 INFO - Running cycle 1/1 for kraken test... 13:56:11 INFO - TEST-INFO | started process 9724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeS6LGk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:23 INFO - PROCESS | 9724 | RSS: Main: 154083328 13:56:23 INFO - PROCESS | 9724 | 13:56:25 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33378/tests/kraken/driver.html?testName=audio-beat-detection) 13:56:26 INFO - PROCESS | 9724 | RSS: Main: 210087936 13:56:26 INFO - PROCESS | 9724 | 13:56:29 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33378/tests/kraken/driver.html?testName=audio-dft) 13:56:30 INFO - PROCESS | 9724 | RSS: Main: 198410240 13:56:30 INFO - PROCESS | 9724 | 13:56:33 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33378/tests/kraken/driver.html?testName=audio-fft) 13:56:34 INFO - PROCESS | 9724 | RSS: Main: 266657792 13:56:34 INFO - PROCESS | 9724 | 13:56:36 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33378/tests/kraken/driver.html?testName=audio-oscillator) 13:56:36 INFO - PROCESS | 9724 | RSS: Main: 175894528 13:56:36 INFO - PROCESS | 9724 | 13:56:39 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:56:39 INFO - PROCESS | 9724 | RSS: Main: 179720192 13:56:39 INFO - PROCESS | 9724 | 13:56:42 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33378/tests/kraken/driver.html?testName=imaging-darkroom) 13:56:43 INFO - PROCESS | 9724 | RSS: Main: 216084480 13:56:43 INFO - PROCESS | 9724 | 13:56:46 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33378/tests/kraken/driver.html?testName=imaging-desaturate) 13:56:47 INFO - PROCESS | 9724 | RSS: Main: 216657920 13:56:47 INFO - PROCESS | 9724 | 13:56:50 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33378/tests/kraken/driver.html?testName=json-parse-financial) 13:56:51 INFO - PROCESS | 9724 | RSS: Main: 216821760 13:56:51 INFO - PROCESS | 9724 | 13:56:52 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:56:53 INFO - PROCESS | 9724 | RSS: Main: 205172736 13:56:53 INFO - PROCESS | 9724 | 13:56:55 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:56:55 INFO - PROCESS | 9724 | RSS: Main: 209174528 13:56:55 INFO - PROCESS | 9724 | 13:56:58 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:56:58 INFO - PROCESS | 9724 | RSS: Main: 219009024 13:56:58 INFO - PROCESS | 9724 | 13:57:01 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:57:02 INFO - PROCESS | 9724 | RSS: Main: 223105024 13:57:02 INFO - PROCESS | 9724 | 13:57:05 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:57:05 INFO - PROCESS | 9724 | RSS: Main: 222883840 13:57:05 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | Cycle 1(1): loaded http://localhost:33378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33378/tests/kraken/driver.html?testName=ai-astar) 13:57:07 INFO - PROCESS | 9724 | RSS: Main: 268111872 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | __start_tp_report 13:57:07 INFO - PROCESS | 9724 | _x_x_mozilla_page_load 13:57:07 INFO - PROCESS | 9724 | _x_x_mozilla_page_load_details 13:57:07 INFO - PROCESS | 9724 | |i|pagename|runs| 13:57:07 INFO - PROCESS | 9724 | |0;ai-astar;117;108;115;114;114;113;113;114;113;114 13:57:07 INFO - PROCESS | 9724 | |1;audio-beat-detection;156;131;162;187;130;158;152;132;192;131 13:57:07 INFO - PROCESS | 9724 | |2;audio-dft;162;162;161;163;164;164;162;162;161;162 13:57:07 INFO - PROCESS | 9724 | |3;audio-fft;75;75;76;123;76;76;75;75;123;75 13:57:07 INFO - PROCESS | 9724 | |4;audio-oscillator;92;95;128;93;95;94;136;92;93;122 13:57:07 INFO - PROCESS | 9724 | |5;imaging-gaussian-blur;116;117;117;117;116;116;116;118;117;117 13:57:07 INFO - PROCESS | 9724 | |6;imaging-darkroom;146;146;146;148;146;146;146;147;147;146 13:57:07 INFO - PROCESS | 9724 | |7;imaging-desaturate;96;95;96;94;95;95;95;95;94;94 13:57:07 INFO - PROCESS | 9724 | |8;json-parse-financial;67;65;67;65;66;67;66;84;66;63 13:57:07 INFO - PROCESS | 9724 | |9;json-stringify-tinderbox;64;63;64;64;74;63;63;65;64;64 13:57:07 INFO - PROCESS | 9724 | |10;stanford-crypto-aes;82;82;82;82;83;85;85;83;84;83 13:57:07 INFO - PROCESS | 9724 | |11;stanford-crypto-ccm;136;132;138;133;131;131;129;129;224;131 13:57:07 INFO - PROCESS | 9724 | |12;stanford-crypto-pbkdf2;183;183;178;176;176;175;177;182;179;184 13:57:07 INFO - PROCESS | 9724 | |13;stanford-crypto-sha256-iterative;69;69;69;68;68;68;67;69;71;67 13:57:07 INFO - PROCESS | 9724 | __end_tp_report 13:57:07 INFO - PROCESS | 9724 | __start_cc_report 13:57:07 INFO - PROCESS | 9724 | _x_x_mozilla_cycle_collect,1846 13:57:07 INFO - PROCESS | 9724 | __end_cc_report 13:57:07 INFO - PROCESS | 9724 | __startTimestamp1462481827800__endTimestamp 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | ------- Summary: start ------- 13:57:07 INFO - PROCESS | 9724 | Number of tests: 14 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.27 (2.0%) stddev-sans-first:2.03 13:57:07 INFO - PROCESS | 9724 | Values: 117.0 108.0 115.0 114.0 114.0 113.0 113.0 114.0 113.0 114.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:157.00 stddev:22.93 (14.6%) stddev-sans-first:24.29 13:57:07 INFO - PROCESS | 9724 | Values: 156.0 131.0 162.0 187.0 130.0 158.0 152.0 132.0 192.0 131.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 13:57:07 INFO - PROCESS | 9724 | Values: 162.0 162.0 161.0 163.0 164.0 164.0 162.0 162.0 161.0 162.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#3] audio-fft Cycles:10 Average:84.90 Median:75.00 stddev:20.09 (26.8%) stddev-sans-first:20.98 13:57:07 INFO - PROCESS | 9724 | Values: 75.0 75.0 76.0 123.0 76.0 76.0 75.0 75.0 123.0 75.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:93.00 stddev:17.37 (18.7%) stddev-sans-first:17.87 13:57:07 INFO - PROCESS | 9724 | Values: 92.0 95.0 128.0 93.0 95.0 94.0 136.0 92.0 93.0 122.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 13:57:07 INFO - PROCESS | 9724 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 116.0 118.0 117.0 117.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:57:07 INFO - PROCESS | 9724 | Values: 146.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 147.0 146.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 13:57:07 INFO - PROCESS | 9724 | Values: 96.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:66.50 stddev:5.89 (8.9%) stddev-sans-first:6.24 13:57:07 INFO - PROCESS | 9724 | Values: 67.0 65.0 67.0 65.0 66.0 67.0 66.0 84.0 66.0 63.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.00 stddev:3.29 (5.1%) stddev-sans-first:3.48 13:57:07 INFO - PROCESS | 9724 | Values: 64.0 63.0 64.0 64.0 74.0 63.0 63.0 65.0 64.0 64.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.20 13:57:07 INFO - PROCESS | 9724 | Values: 82.0 82.0 82.0 82.0 83.0 85.0 85.0 83.0 84.0 83.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:132.50 stddev:29.16 (22.0%) stddev-sans-first:30.87 13:57:07 INFO - PROCESS | 9724 | Values: 136.0 132.0 138.0 133.0 131.0 131.0 129.0 129.0 224.0 131.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.50 stddev:3.40 (1.9%) stddev-sans-first:3.33 13:57:07 INFO - PROCESS | 9724 | Values: 183.0 183.0 178.0 176.0 176.0 175.0 177.0 182.0 179.0 184.0 13:57:07 INFO - PROCESS | 9724 | 13:57:07 INFO - PROCESS | 9724 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 13:57:07 INFO - PROCESS | 9724 | Values: 69.0 69.0 69.0 68.0 68.0 68.0 67.0 69.0 71.0 67.0 13:57:07 INFO - PROCESS | 9724 | -------- Summary: end -------- 13:57:07 INFO - PROCESS | 9724 | 13:57:09 INFO - TEST-INFO | 9724: exit 0 13:57:09 INFO - TEST-OK | kraken | took 65111ms 13:57:09 INFO - SUITE-END | took 1185s 13:57:09 INFO - Completed test suite (00:19:45) 13:57:09 INFO - javascript benchmark 13:57:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.408158164413, 2699.1362763915554, 2729.2767416634583, 2731.685856126545, 2738.9452210955783, 4635.58279754822, 4702.741349225791, 4710.222813235816, 4768.332433459314, 4785.258284965827, 4712.222483290261, 4770.618350531958, 4820.373351464314, 4835.782389792459, 4847.684900481467, 4305.956940430603, 4307.978460107695, 4338.826446942135, 4398.406215160944, 4418.425604671388, 4376.256036473791, 4418.712783669067, 4496.55034496551, 4535.750533720644, 4537.0, 4257.0, 4391.165678521071, 4479.664025198107, 4498.3252512123445, 4500.504944456107, 4284.186004659105, 4288.313869780851, 4292.24885645014, 4319.784010799479, 4357.0, 4284.464441944757, 4341.956580434218, 4346.239408103601, 4347.7173983690955, 4405.98662307671, 4557.179707652621, 4690.413698287714, 4701.64737644678, 4717.363155973968, 4720.504347043579, 5096.184610462308, 5159.458256883011, 5170.043541944752, 5183.533481986639, 5233.162693968985, 5186.092433824066, 5190.480951904817, 5220.634555581111, 5249.501297376743, 5258.211268309746, 4686.297055441711, 4698.835540756126, 4901.411830580318, 4906.215005599087, 4914.975425122851, 5165.690058596496, 5239.869003274948, 5254.238135470336, 5258.92111618326, 5261.0, 5001.374828146481, 5045.117104506697, 5046.84859454217, 5052.646314757932, 5055.570276526537, 4996.925660982906, 5027.522385373383, 5077.213031980049, 5082.898342033139, 5088.618353623493, 5041.773120209599, 5042.571381432546, 5045.2432135180015, 5049.0, 5091.694498330112, 5026.949730502722, 5030.320906677625, 5032.672876263031, 5038.294638750578, 5077.289179514871, 4210.031692710693, 4247.532771395144, 4255.276602977501, 4349.717268377545, 4397.648188144941, 3737.8691745788765, 3777.1690228149764, 3799.3161230978135, 3833.3291673956946, 3887.475190849199, 4386.8903277417685, 4392.165488557164, 4421.403110580095, 4425.712328698624, 4455.04216593434, 4987.10232158215, 5118.385793704705, 5160.767765450564, 5162.767675454614, 5174.6377753557645, 4378.277584198571, 4422.314541246112, 4426.18115648606, 4429.756363400044, 4445.310976798602, 4665.533446655375, 4673.275642275453, 4676.111538807616, 4712.434507859079, 4716.268978308368, 4631.861044168681, 4836.177849765478, 4872.610191184696, 4883.462819089827, 4883.8290659826735, 5147.819826306061, 5162.793488260578, 5194.428612852659, 5206.947930520798, 5250.343707036621, 4877.561019508261, 4880.609551235963, 4888.899997500534, 4891.437484689164, 4935.876603084952, 4886.780094895667, 5019.347484826949, 5060.443351231435, 5117.053345131163, 5126.512981266774, 5145.459726728789, 5158.123119069842, 5160.664556803796, 5166.664166829294, 5206.8958620828125, 5021.372328458942, 5023.748812559431, 5024.673396229234, 5025.84922452327, 5078.822241221539, 4870.512948705101, 4915.852524424273, 4947.307376967299, 4950.727709975986, 5009.924851127309, 4885.511448855086, 4888.6577939543895, 4902.240152776325, 4953.331300274417, 4957.504249575014, 5005.099082165245, 5007.0, 5010.048090862724, 5051.217061355495, 5056.974715126401, 4779.139754844023, 4836.202026665561, 4885.438174609823, 4898.314236007033, 4899.363082799213], "value": 4698.3533605402945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6314763829693, 602.0637908052977, 602.9668368239745, 604.9939500604993, 610.2524407600688, 27385.726142738567, 41427.55003574872, 42785.78607106968, 42874.785626071905, 42904.356434653426, 42011.0, 42436.15127697452, 42437.151256974845, 42555.78722106385, 42600.360994585026, 8043.436959412828, 8146.26683598476, 8170.918290817105, 8173.346132309431, 8173.754787356389, 8037.839243215132, 8134.023917129953, 8169.591520423985, 8171.223733745284, 8173.79565510864, 8149.348052155813, 8230.2592766651, 8231.053428855668, 8232.300254478376, 8238.546879921601, 8157.0, 8167.836643267161, 8185.3451723861945, 8218.096009438957, 8220.219079187467, 8061.2744852963515, 8121.30968867647, 8125.268725814646, 8137.2676459118375, 8138.0, 39666.0, 39676.40485392721, 39821.0, 39832.60167398347, 40118.59881401178, 3154.747620190379, 3394.592648882125, 3625.782453052825, 3850.441685955521, 3928.253631809947, 29625.0, 29886.0, 30081.548776768366, 30262.84868575665, 31428.37143257122, 2763.553766761644, 2930.164903002634, 2952.9409411811857, 2966.362232120083, 3013.03582853487, 204604.0, 255547.05585304426, 256932.0, 258309.70845145843, 258395.0, 56950.43049569534, 59108.0, 59534.40465595289, 59573.0, 59616.70191649014, 62971.0, 65632.67183664147, 65644.67177664081, 71601.0, 71775.0, 15824.0, 16114.0, 16117.0, 16127.435539756052, 16132.919335403249, 12002.819957700642, 12069.094817888517, 12104.273743575413, 12104.697382565506, 12111.0, 19613.803861961198, 19692.50768730793, 19732.60534789296, 19747.50631234202, 19748.901255493918, 7110.431165506747, 7132.786016419515, 7199.532030418006, 7326.633668316669, 7458.85082298351, 840.5335039053261, 919.8804155459882, 930.6417029443713, 972.562346943864, 995.8356871116184, 27636.309092272855, 29175.64480084775, 29256.853715731286, 29440.411191776046, 29736.40527189444, 968.4576637083256, 1039.740064983754, 1087.3475914451424, 1099.120703437263, 1125.1055410948316, 15699.0, 15739.527814165593, 15824.60438489047, 15825.920870395574, 16033.919830401006, 348057.0, 348066.0, 350254.0, 351382.0, 351402.0, 52769.47230527645, 53177.202341964905, 53360.73319633377, 53421.7328913353, 53564.196537051976, 1162.511745067074, 1256.1269917407496, 1298.3962457457328, 1300.2978391668394, 1306.137948953686, 28325.291867703472, 29180.0, 29576.556351655174, 29758.553621696126, 30022.69977300199, 44050.33924491071, 44476.77761611301, 44616.0, 44675.553244468436, 44683.77658111689, 265083.0, 265384.0, 266023.0, 266147.0, 267852.0, 20988.790112098683, 26419.339516512242, 26468.205953821416, 27534.311642209104, 27610.44779104447, 43628.781856090514, 43735.78132109319, 43882.341764872916, 44717.329240060775, 45108.32337514874, 37138.0, 37858.43212351872, 37893.24213515659, 38389.0, 38987.0, 36067.27865442729, 37630.62369376271, 37773.0, 37877.43183852299, 39711.0, 38024.61975380211, 38084.619153808104, 38583.22833543257, 38592.0, 38842.6115738839, 33070.0, 34161.48757768685, 34385.484217737256, 34639.0, 34935.0, 25323.620145698198, 26331.473370532865, 26430.0, 26439.33901652474, 26721.465570688866], "value": 18270.379756181446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7764130342446, 378.732993239766, 384.8353014294591, 395.24508189358295, 396.1996766531606, 15644.765328520067, 16712.83287167128, 17689.911550442244, 17831.55421114473, 17868.463946081607, 14806.925965370185, 15211.391544338214, 15346.462873799419, 15439.536813895602, 15553.0, 5037.84886453406, 5129.589632829365, 5142.434332223453, 5151.201563757623, 5224.216367544861, 3643.271345730851, 5578.191162281467, 5848.64908105515, 5869.794557190499, 5968.343482216953, 5901.822945311647, 6019.909701354483, 6020.45815876571, 6040.426159514839, 6054.273487181545, 5849.444302791228, 5976.820695379146, 6010.459058684717, 6017.518598512131, 6018.337982821908, 3298.208429976812, 3471.5139880416764, 3485.7734247273847, 3503.8248087595516, 4926.285688575136, 19328.903355483275, 19755.11102000399, 20504.897475512676, 20542.17831286747, 20550.38348849537, 1998.2206939293542, 2029.756429228502, 2033.6949457581482, 2264.0377839418347, 2302.481941563135, 12752.234865908074, 12904.935475322658, 13122.803157952638, 13128.409221585052, 13177.86822131776, 1706.1980868991554, 1777.1824960518177, 1843.1337271482382, 1851.3242666426793, 1878.2487005197893, 63759.04361434582, 63790.68104659493, 64504.0, 65163.0, 65721.67139164322, 9281.350305478552, 9394.792223827395, 9439.52802359893, 9556.76108097303, 9822.508874556386, 12946.0, 13111.409986550438, 13126.803097953538, 13130.671733206555, 13143.934280328729, 7491.8501629967095, 7562.697492100365, 7596.772096837104, 7709.761900002012, 7790.0, 7426.220246874109, 7494.925050749532, 7515.887261691079, 7586.431017673696, 7622.504537205064, 5984.371640977722, 6109.877802443926, 6191.133241346215, 6194.101855230966, 6226.470749986212, 1561.8360072192484, 1660.3856573068042, 1765.9823401765818, 1786.8749187557007, 1835.586992926581, 887.9378443508892, 934.4113208678489, 963.1091240602415, 991.2020823237364, 1037.870266216723, 17043.488695339158, 17058.147092645566, 17197.0, 17226.655466890592, 17578.208980595904, 932.8554074118523, 938.8357037518407, 942.495764765847, 955.2214944819949, 1010.5604062232952, 9873.308868379288, 10058.34620749649, 10202.540885660163, 10221.386716797017, 10352.430616316175, 373244.0, 383290.0, 386922.0, 388157.0, 389489.0, 40115.0, 63849.0, 66256.33743662502, 66569.75013396374, 67133.66433167802, 968.4818622037176, 994.1947022911465, 999.4003597841237, 1020.0309705779391, 1025.5487585462372, 15154.16652084146, 15259.847401526287, 15348.30932608013, 15413.922930385725, 15631.0, 31165.0, 31384.68615313909, 32069.67930320667, 32101.197470063435, 32731.836340818143, 40418.39372409475, 41516.16967660569, 41835.581644184385, 42095.789521053426, 42313.365299519915, 7432.293932076444, 7774.339181169664, 7780.377569794289, 7796.532208067534, 7851.842963140591, 9949.950250248703, 10880.347179169275, 11141.72145696364, 11475.196736228718, 11534.192606517463, 9629.085236902483, 9897.406155630686, 10045.849312260469, 10062.345947513388, 10339.844902326622, 9602.375845570015, 9746.85379719319, 9887.357321774061, 9897.950510247403, 9909.108180263811, 9861.556229969525, 9978.401295922267, 10001.499925003865, 10002.099811017044, 10147.84778228342, 7419.962900185465, 7431.219721929119, 7546.698132074655, 7609.581473019037, 7733.8839917400155, 9629.422234665943, 9713.0, 9799.042679697495, 9836.114749672564, 10151.7462063449], "value": 8224.821575441134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.211750831993, 1500.5348342013974, 1521.4826958833999, 1676.212180275271, 1827.2782251010842, 6596.406323430891, 7314.414846812256, 7526.849463010736, 7552.0, 7714.498557593766, 7281.854362912739, 7429.6285185740635, 7437.25627437256, 7437.702491900331, 7463.738769143081, 2176.4450065233345, 2202.6695995600626, 2205.658122990931, 2212.7676593957644, 2213.457702862801, 2140.625390556654, 2176.249194028058, 2177.4991751897073, 2178.1287485005964, 2180.062573093569, 2099.9265025724103, 2107.388857231401, 2125.3836387447623, 2128.8084072433476, 2131.232756207764, 2150.9784902150936, 2154.127578330763, 2155.0, 2156.956860862782, 2160.5786871560053, 2085.061722225005, 2143.3141394753684, 2144.8713077215416, 2145.2384403536676, 2145.410012246629, 7421.294976977232, 7530.246975302426, 7580.128285247157, 7586.355159811367, 7588.658510366991, 4477.194105061088, 4628.352030715702, 4642.814287428499, 4643.558861908114, 4656.092062047902, 2875.62616859809, 2877.5827505011657, 2900.76793856491, 2901.680815110336, 2943.1611990582796, 947.3984020147187, 951.267524006518, 958.1999030809283, 974.2985050763439, 988.0810845913297, 10310.896891031143, 10323.793524129474, 10361.171106311476, 10454.268201225917, 10464.947675261652, 3745.662890339828, 3867.806609669505, 3924.0582260257333, 3926.489556357655, 3997.2804895119157, 8273.710420135267, 8368.707095251637, 8370.623321950527, 8387.62255698495, 8415.45299555527, 4438.312061630452, 4448.199324121624, 4460.955390446119, 4466.888327791831, 4475.239209334421, 3498.440249560109, 3984.8406063757707, 4057.229126465962, 4109.856155034559, 4176.4570605821045, 3379.9155021124175, 3413.4367829308385, 3480.129967508123, 3500.5974312953826, 3508.122969257686, 1053.1574740207802, 1063.7500187455942, 1070.2775626452114, 1071.1698433713777, 1079.611339917629, 905.158202871336, 915.5651065743851, 918.3855436010182, 929.9860502092474, 939.4973689076311, 5507.311586051744, 5526.861828454321, 5574.804881829116, 5630.436956304418, 5700.686462244616, 886.9201771840566, 887.8401887660283, 891.9063498332712, 902.444996327254, 959.8176346494143, 3826.330392181357, 3913.6477717005605, 3953.8616148435244, 3956.347202711578, 4022.3966405039478, 8967.058458861857, 9082.86375704365, 9263.814723705487, 9274.350795444388, 9411.200047995997, 9237.3533852631, 9292.53537323131, 9345.719628411158, 9395.90604093964, 9401.24790016797, 7209.315115064061, 7244.891326630105, 7296.854062918712, 7340.486165968331, 7376.114866216089, 5490.231367608618, 5497.092979658311, 5529.419410961952, 5536.557075434036, 5684.9431505684415, 7915.327197188303, 8080.393970452122, 8105.392095592736, 8745.868811967954, 8860.822783544421, 8370.330373569977, 8424.326053915795, 8436.11420800807, 8459.365547583833, 8467.49195048299, 6056.3035250946705, 6465.741370345321, 6496.0, 6660.766873159416, 6752.763653272112, 7374.1151061872915, 7514.286142816423, 7539.095308562788, 7561.7353392633195, 7591.962040189764, 6611.867762644624, 6837.35045170708, 6837.965810170917, 6986.231514533499, 6997.160340759141, 6493.935060649333, 6542.149520562297, 6583.637899915359, 6622.867542649024, 6690.59856408617, 6359.745610175726, 6375.808725738235, 6411.038344248213, 6418.743250269937, 6425.935740642533, 4742.952570474389, 4874.975625121851, 4876.975615122044, 4880.048390563806, 4940.456549779449, 4699.953000469952, 4794.760261986817, 4829.0, 4894.119058569349, 4945.085159245551], "value": 4110.800471188982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1310574828389, 293.85307346326834, 296.2283252128206, 297.4556561492469, 303.6705174885249, 4745.962583946272, 4786.401699787527, 4796.625670293201, 4802.03959208158, 4815.277708343741, 4698.130845793522, 4744.620430365571, 4755.595774359175, 4758.619310455164, 4759.904801903968, 3560.679538841497, 3671.733252028046, 3678.9448158277514, 3691.3724666806706, 3694.0, 3649.59854416014, 3678.411454167334, 3809.7904615246152, 3822.3310920588924, 3840.1551658635194, 3724.255148970217, 3761.7742935423826, 3773.2264885698364, 3774.113083425407, 3783.2811765764554, 3608.657177568127, 3755.511783468159, 3774.3772277574167, 3775.4903088083033, 3782.583915769263, 3137.7646676499353, 3230.0471360948577, 3234.611846578402, 3237.7211001654214, 3243.8702451901895, 4472.709273897186, 4551.226291530448, 4613.777349002517, 4641.976790116061, 4644.9535504644855, 4306.676999225071, 4319.611234988866, 4328.307470804656, 4329.545397733255, 4329.740215587075, 4866.780835556969, 5001.999600079962, 5015.899682006376, 5044.0, 5050.621203409759, 3613.981930090359, 3617.8422904670515, 3629.4555816627453, 3641.7086633069557, 3654.634536546324, 5188.92216616751, 5205.8958820823755, 5219.347581552268, 5224.92162617561, 5227.47725227478, 3647.2705458907794, 3733.962660373416, 3737.458068580095, 3748.5755412943454, 3774.3206222879594, 3758.624137586274, 3770.3024940386117, 3788.6969042477085, 3793.829277682511, 3794.2601192767147, 4254.191703576311, 4256.425382573375, 4265.125649241898, 4267.786610669516, 4285.5928686774705, 4990.30135780991, 4991.425986011583, 5001.0, 5018.365358186981, 5022.874428139326, 1243.527361994341, 1248.5942068827485, 1283.2621242785435, 1294.3916359311297, 1297.357807885084, 879.3624622149018, 879.8254330468895, 894.8344556256983, 899.7750562359411, 903.7198468474794, 4246.511651160156, 4307.234034046026, 4313.956860431418, 4317.352397140454, 4347.152305300436, 5024.472430394829, 5052.696838189647, 5053.8736531587, 5099.643024988215, 5123.462036486189, 4263.786810659517, 4340.197063543254, 4364.672649551297, 4366.978165109154, 4378.60592546666, 2534.379077126116, 2544.727636181909, 2656.296081538394, 2671.7061123276426, 2706.391062011071, 4791.976040119777, 4897.216445368724, 4915.287283343967, 4923.507649235119, 4934.235193545006, 5292.52367286946, 5298.81454149103, 5301.496357845998, 5309.097453432925, 5322.866928326823, 4781.808727650925, 4871.196252618278, 4893.681910675866, 4902.926456103161, 4908.337374454403, 5153.268767553202, 5168.819091331786, 5170.741462926914, 5174.948250517597, 5175.273802861933, 4986.80052797884, 5084.567811735896, 5091.261767043832, 5093.516115968977, 5117.257997590403, 4682.836100736458, 4820.542048505386, 4838.588719958843, 4877.853664390074, 4915.321149973344, 3730.3285408626707, 3753.436984452354, 3753.943690844585, 3761.586225515246, 3761.6614504693616, 5098.719570423514, 5156.215643552439, 5176.948230517797, 5178.275041494269, 5191.740412979411, 4736.8105275788585, 5004.499550044967, 5014.398272207212, 5028.723420211923, 5043.974780126223, 4962.379702537183, 4996.950030499648, 5024.698518088926, 5025.894303253279, 5034.59723222134, 4917.459079501324, 4932.605391568738, 4945.4807245238735, 4964.67729597575, 4991.28149528589, 4894.51054894522, 5046.697198168122, 5067.366579177603, 5078.644494885322, 5104.157813960804, 4968.205087186033, 4975.353204083591, 4990.401151861654, 4998.350214472095, 5002.549770520671], "value": 3784.404923625509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.6992278281732, 744.2631794523422, 779.2597032818824, 793.3534169651737, 807.652709334986, 11283.153763467732, 11326.32042077475, 11423.771524569504, 11452.484638191281, 11467.59863404781, 12235.755284894296, 12297.877021229786, 12320.383980800969, 12348.691282717915, 12369.257844529335, 670.9630970296631, 827.1273806134526, 846.8052347959973, 861.8233262181269, 874.33113668044, 870.9129087091272, 870.921617054465, 874.1695389380083, 874.2568816505983, 874.6282829797311, 925.4447331601019, 927.7773334399762, 928.8003079337941, 929.2380248196481, 929.6281487405058, 704.7075463682565, 724.2142275630947, 724.9601271930042, 731.5391303478827, 924.3621900888365, 655.1941112431688, 678.3691167214489, 678.4131726056975, 678.8608335291253, 679.4564348521212, 11730.88269117315, 11739.060875130055, 11739.471723772365, 11742.70643233926, 11758.823617645741, 11696.590619328283, 12033.338166400845, 12142.392880355947, 12216.877831221664, 12244.204126731735, 10810.675704723522, 10819.404932728698, 10938.179636527293, 10994.505247263893, 11104.056155226815, 4079.0822065035427, 4079.1433798902267, 4111.239420707178, 4120.690948178899, 4266.189424009459, 41972.79013604912, 42011.0, 42013.78993105046, 42103.36844947328, 42314.0, 9268.25853931684, 9589.041095890356, 9642.95178524117, 9705.641210230573, 9912.504374781232, 15485.767713484307, 15705.764413533807, 15719.292631831595, 15747.763783543256, 15767.605809854616, 6364.1408409865, 6554.80335589933, 6639.734410623618, 6748.358905903931, 6868.141482314711, 3710.8330125144435, 3743.5133432654125, 3783.981080094582, 3791.4881490998914, 3855.749376290532, 2650.178444682116, 2724.7547720705234, 2738.602902579115, 2739.0413355325477, 2745.23133522614, 507.1226777674644, 509.9082165210224, 528.1259515501774, 532.1060618161448, 532.4010488200774, 557.7127779193719, 572.4046991129262, 577.3014652270799, 582.1326223926404, 597.3011576455557, 6836.4530837532875, 6869.293978209945, 6911.5853048817235, 6949.895751563629, 7099.3965512930945, 490.7521701540699, 499.0144464682296, 537.5189205660912, 567.5459632294148, 568.0882184094469, 3254.1286321510943, 3360.9663903361143, 3388.745844061705, 3390.288039511681, 3457.239407330383, 48364.27453588199, 49602.0, 49750.0, 49796.0, 49983.500164998615, 45322.77338613286, 46498.5350146501, 46622.300665490046, 46642.30036549454, 47590.0, 41979.79010104991, 43343.78328108403, 43950.12099758051, 44249.690037195745, 44817.10365792666, 8122.390820688353, 8370.330373570221, 8383.958080209804, 8410.243078122998, 8477.872831907403, 29406.411871762873, 29656.0, 29944.101676949726, 30893.0, 31084.68915310818, 34778.82610586931, 35909.0, 38318.80840595891, 38570.80714596409, 38769.80615096907, 9569.856452153363, 9689.903100969183, 10787.406692631666, 10845.511951962022, 11750.764984700087, 10752.462376881282, 11018.779624407627, 11045.392503412068, 11534.307941523535, 11895.167338286583, 11018.449077546251, 11044.668659940215, 11053.28153670009, 11206.7758644825, 11212.103031757602, 10822.67531974042, 10910.2362834604, 10983.121350291798, 11375.829362559734, 11568.07455403549, 10343.586256549654, 10676.092532134855, 10814.891851081704, 11195.944020279847, 11214.0, 8860.291176705978, 8969.416987896027, 9120.270378369847, 9293.581788819654, 9441.52792360393, 8938.955305223431, 9162.908370916472, 9263.86104208424, 9308.627654893728, 9387.342885998189], "value": 5875.431484107878, "unit": "score"}], "name": "dromaeo_css", "value": 6333.433733134929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 162.0, 187.0, 130.0, 158.0, 152.0, 132.0, 192.0, 131.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 164.0, 164.0, 162.0, 162.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 123.0, 76.0, 76.0, 75.0, 75.0, 123.0, 75.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 128.0, 93.0, 95.0, 94.0, 136.0, 92.0, 93.0, 122.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 66.0, 67.0, 66.0, 84.0, 66.0, 63.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 74.0, 63.0, 63.0, 65.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 83.0, 85.0, 85.0, 83.0, 84.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 138.0, 133.0, 131.0, 131.0, 129.0, 129.0, 224.0, 131.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 178.0, 176.0, 176.0, 175.0, 177.0, 182.0, 179.0, 184.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 71.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1580.5, "alertThreshold": 2.0}]} 13:57:09 INFO - Return code: 0 13:57:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:57:09 ERROR - # TBPL SUCCESS # 13:57:09 INFO - Running post-action listener: _resource_record_post_action 13:57:09 INFO - Running post-run listener: _resource_record_post_run 13:57:10 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541769728; Read time: 268; Write time: 1508800 13:57:10 INFO - install - Wall time: 16s; CPU: 20.0%; Read bytes: 4096; Write bytes: 249184256; Read time: 264; Write time: 961056 13:57:10 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292405248; Read time: 4; Write time: 547720 13:57:10 INFO - Running post-run listener: _upload_blobber_files 13:57:10 INFO - Blob upload gear active. 13:57:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:57:10 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 13:57:10 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'] 13:57:10 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 13:57:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:57:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:57:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:57:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:12 INFO - (blobuploader) - INFO - Done attempting. 13:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:57:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:12 INFO - (blobuploader) - INFO - Done attempting. 13:57:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:57:12 INFO - Return code: 0 13:57:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:57:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:57:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c363f4bdb4e2c1444d8898fedc0f93f12039af8bf973190ec0ac1deca706cbd167d226b287bb93bbabb6128b73df91d14ca4623ff6df65eb8e6e809c30d8e41d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf48b927b7c3f514dbb286d83da2a201cd6709f44eb3c716a7203b01add6d9a423f1b0c2d511e1629c2b3134657a4679238243ab19d2ec633d179f9fd58d0008"} 13:57:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:57:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:57:12 INFO - Contents: 13:57:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c363f4bdb4e2c1444d8898fedc0f93f12039af8bf973190ec0ac1deca706cbd167d226b287bb93bbabb6128b73df91d14ca4623ff6df65eb8e6e809c30d8e41d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf48b927b7c3f514dbb286d83da2a201cd6709f44eb3c716a7203b01add6d9a423f1b0c2d511e1629c2b3134657a4679238243ab19d2ec633d179f9fd58d0008"} 13:57:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:57:12 INFO - Copying logs to upload dir... 13:57:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:57:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.517858 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-05 13:57:12.661122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:57:12.664950) ========= 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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 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/c363f4bdb4e2c1444d8898fedc0f93f12039af8bf973190ec0ac1deca706cbd167d226b287bb93bbabb6128b73df91d14ca4623ff6df65eb8e6e809c30d8e41d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf48b927b7c3f514dbb286d83da2a201cd6709f44eb3c716a7203b01add6d9a423f1b0c2d511e1629c2b3134657a4679238243ab19d2ec633d179f9fd58d0008"} build_url:https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/d__rUQpAQ4ey6ofedbVD6A/artifacts/public/build/firefox-49.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/c363f4bdb4e2c1444d8898fedc0f93f12039af8bf973190ec0ac1deca706cbd167d226b287bb93bbabb6128b73df91d14ca4623ff6df65eb8e6e809c30d8e41d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf48b927b7c3f514dbb286d83da2a201cd6709f44eb3c716a7203b01add6d9a423f1b0c2d511e1629c2b3134657a4679238243ab19d2ec633d179f9fd58d0008"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 13:57:12.690225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:57:12.690562) ========= 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=df17445c3590ff7897617a0e00000225-1462480588.633626-1901499587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 13:57:12.775508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:57:12.775832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 13:57:12.776134) ========= ========= Total master_lag: 0.17 =========