builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1461422288.59 results: success (0) buildid: 20160423070046 builduid: acc6e6d851764061b88d97355ca26ec9 revision: 1aabbe445e730853e83e9585d888fe548320226a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.593757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.594140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.594419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.623865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.624128) ========= 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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 07:38:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.3M=0s 2016-04-23 07:38:08 (30.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.816922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.817201) ========= 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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.866064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:08.866364) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1aabbe445e730853e83e9585d888fe548320226a --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 1aabbe445e730853e83e9585d888fe548320226a --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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 07:38:08,924 truncating revision to first 12 chars 2016-04-23 07:38:08,924 Setting DEBUG logging. 2016-04-23 07:38:08,924 attempt 1/10 2016-04-23 07:38:08,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1aabbe445e73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 07:38:09,183 unpacking tar archive at: fx-team-1aabbe445e73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:09.421551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:09.421837) ========= script_repo_revision: 1aabbe445e730853e83e9585d888fe548320226a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:09.422191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:09.422460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:38:09.431260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-23 07:38:09.431534) ========= /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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:09 INFO - MultiFileLogger online at 20160423 07:38:09 in /builds/slave/test 07:38:09 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 07:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:09 INFO - {'append_to_log': False, 07:38:09 INFO - 'base_work_dir': '/builds/slave/test', 07:38:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:09 INFO - 'branch': 'Fx-Team-Non-PGO', 07:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:09 INFO - 'config_files': ('talos/linux_config.py',), 07:38:09 INFO - 'default_actions': ('clobber', 07:38:09 INFO - 'read-buildbot-config', 07:38:09 INFO - 'download-and-extract', 07:38:09 INFO - 'populate-webroot', 07:38:09 INFO - 'create-virtualenv', 07:38:09 INFO - 'install', 07:38:09 INFO - 'run-tests'), 07:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:09 INFO - 'download_minidump_stackwalk': True, 07:38:09 INFO - 'download_symbols': 'ondemand', 07:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:09 INFO - 'installer_path': 'installer.exe', 07:38:09 INFO - 'log_level': 'info', 07:38:09 INFO - 'log_name': 'talos', 07:38:09 INFO - 'log_to_console': True, 07:38:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:09 INFO - 'opt_config_files': (), 07:38:09 INFO - 'pip_index': False, 07:38:09 INFO - 'sps_profile': False, 07:38:09 INFO - 'sps_profile_interval': 0, 07:38:09 INFO - 'suite': 'dromaeojs', 07:38:09 INFO - 'system_bits': '32', 07:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:09 INFO - 'title': 'talos-linux64-ix-050', 07:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:09 INFO - 'use_talos_json': True, 07:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:09 INFO - 'work_dir': 'build'} 07:38:09 INFO - ##### 07:38:09 INFO - ##### Running clobber step. 07:38:09 INFO - ##### 07:38:09 INFO - Running pre-action listener: _resource_record_pre_action 07:38:09 INFO - Running main action method: clobber 07:38:09 INFO - rmtree: /builds/slave/test/build 07:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:10 INFO - Running post-action listener: _resource_record_post_action 07:38:10 INFO - ##### 07:38:10 INFO - ##### Running read-buildbot-config step. 07:38:10 INFO - ##### 07:38:10 INFO - Running pre-action listener: _resource_record_pre_action 07:38:10 INFO - Running main action method: read_buildbot_config 07:38:10 INFO - Using buildbot properties: 07:38:10 INFO - { 07:38:10 INFO - "project": "", 07:38:10 INFO - "product": "firefox", 07:38:10 INFO - "script_repo_revision": "production", 07:38:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:38:10 INFO - "repository": "", 07:38:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:38:10 INFO - "buildid": "20160423070046", 07:38:10 INFO - "pgo_build": "False", 07:38:10 INFO - "basedir": "/builds/slave/test", 07:38:10 INFO - "buildnumber": 2870, 07:38:10 INFO - "slavename": "talos-linux64-ix-050", 07:38:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:38:10 INFO - "platform": "ubuntu64_hw", 07:38:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:38:10 INFO - "branch": "fx-team", 07:38:10 INFO - "repo_path": "integration/fx-team", 07:38:10 INFO - "revision": "1aabbe445e730853e83e9585d888fe548320226a", 07:38:10 INFO - "stage_platform": "linux64", 07:38:10 INFO - "builduid": "acc6e6d851764061b88d97355ca26ec9", 07:38:10 INFO - "slavebuilddir": "test" 07:38:10 INFO - } 07:38:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:38:10 INFO - Running post-action listener: _resource_record_post_action 07:38:10 INFO - ##### 07:38:10 INFO - ##### Running download-and-extract step. 07:38:10 INFO - ##### 07:38:10 INFO - Running pre-action listener: _resource_record_pre_action 07:38:10 INFO - Running main action method: download_and_extract 07:38:10 INFO - mkdir: /builds/slave/test/build/tests 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:10 INFO - https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:38:12 INFO - Downloaded 1361 bytes. 07:38:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:38:12 INFO - Using the following test package requirements: 07:38:12 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:38:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'jsshell-linux-x86_64.zip'], 07:38:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:38:12 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:38:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:12 INFO - https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:13 INFO - Downloaded 22285608 bytes. 07:38:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:38:14 INFO - Return code: 0 07:38:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:38:14 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')]} 07:38:14 INFO - https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:15 INFO - Downloaded 22285608 bytes. 07:38:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:38:16 INFO - Return code: 0 07:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:16 INFO - https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:38:17 INFO - Downloaded 10840145 bytes. 07:38:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:38:18 INFO - Return code: 0 07:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:18 INFO - https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:38:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:38:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:38:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:19 INFO - Downloaded 54742048 bytes. 07:38:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:38:19 INFO - mkdir: /builds/slave/test/properties 07:38:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:19 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:19 INFO - Contents: 07:38:19 INFO - build_url:https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:38:20 INFO - Running post-action listener: _resource_record_post_action 07:38:20 INFO - Running post-action listener: set_extra_try_arguments 07:38:20 INFO - ##### 07:38:20 INFO - ##### Running populate-webroot step. 07:38:20 INFO - ##### 07:38:20 INFO - Running pre-action listener: _resource_record_pre_action 07:38:20 INFO - Running main action method: populate_webroot 07:38:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:20 INFO - '--tppagecycles', 07:38:20 INFO - '7'], 07:38:20 INFO - 'tests': ['tsvgm']}}, 07:38:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['damp', 'tps']}, 07:38:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'tests': ['damp', 'tps']}, 07:38:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['dromaeo_dom']}, 07:38:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['a11yr', 07:38:20 INFO - 'ts_paint', 07:38:20 INFO - 'tpaint', 07:38:20 INFO - 'sessionrestore', 07:38:20 INFO - 'sessionrestore_no_auto_restore', 07:38:20 INFO - 'tabpaint']}, 07:38:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['tsvgx', 07:38:20 INFO - 'tsvgr_opacity', 07:38:20 INFO - 'tart', 07:38:20 INFO - 'tscrollx', 07:38:20 INFO - 'cart']}, 07:38:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:20 INFO - 'tsvgr_opacity', 07:38:20 INFO - 'tart', 07:38:20 INFO - 'tscrollx', 07:38:20 INFO - 'cart']}, 07:38:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'talos_options': ['--disable-e10s'], 07:38:20 INFO - 'tests': ['tp5o']}, 07:38:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'tests': ['tp5o']}, 07:38:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'talos_options': ['--disable-e10s', 07:38:20 INFO - '--xperf_path', 07:38:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:20 INFO - 'tests': ['tp5n']}, 07:38:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:20 INFO - 'talos_options': ['--xperf_path', 07:38:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:20 INFO - 'tests': ['tp5n']}}, 07:38:20 INFO - 'talos.zip': {'path': '', 07:38:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:20 INFO - Running post-action listener: _resource_record_post_action 07:38:20 INFO - ##### 07:38:20 INFO - ##### Running create-virtualenv step. 07:38:20 INFO - ##### 07:38:20 INFO - Running pre-action listener: _resource_record_pre_action 07:38:20 INFO - Running main action method: create_virtualenv 07:38:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:38:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:20 INFO - Using real prefix '/usr' 07:38:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:23 INFO - Installing pip.................done. 07:38:23 INFO - Return code: 0 07:38:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:38:23 INFO - Using env: {'DISPLAY': ':0', 07:38:23 INFO - 'HOME': '/home/cltbld', 07:38:23 INFO - 'LANG': 'en_US.UTF-8', 07:38:23 INFO - 'LANGUAGE': 'en_US:en', 07:38:23 INFO - 'LOGNAME': 'cltbld', 07:38:23 INFO - 'MAIL': '/var/mail/cltbld', 07:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:23 INFO - 'MOZ_NO_REMOTE': '1', 07:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:23 INFO - 'NO_EM_RESTART': '1', 07:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:23 INFO - 'PWD': '/builds/slave/test', 07:38:23 INFO - 'SHELL': '/bin/bash', 07:38:23 INFO - 'SHLVL': '1', 07:38:23 INFO - 'TERM': 'linux', 07:38:23 INFO - 'TMOUT': '86400', 07:38:23 INFO - 'USER': 'cltbld', 07:38:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:23 INFO - '_': '/tools/buildbot/bin/python'} 07:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:38:23 INFO - Cleaning up... 07:38:23 INFO - Return code: 0 07:38:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:38:23 INFO - Using env: {'DISPLAY': ':0', 07:38:23 INFO - 'HOME': '/home/cltbld', 07:38:23 INFO - 'LANG': 'en_US.UTF-8', 07:38:23 INFO - 'LANGUAGE': 'en_US:en', 07:38:23 INFO - 'LOGNAME': 'cltbld', 07:38:23 INFO - 'MAIL': '/var/mail/cltbld', 07:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:23 INFO - 'MOZ_NO_REMOTE': '1', 07:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:23 INFO - 'NO_EM_RESTART': '1', 07:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:23 INFO - 'PWD': '/builds/slave/test', 07:38:23 INFO - 'SHELL': '/bin/bash', 07:38:23 INFO - 'SHLVL': '1', 07:38:23 INFO - 'TERM': 'linux', 07:38:23 INFO - 'TMOUT': '86400', 07:38:23 INFO - 'USER': 'cltbld', 07:38:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:23 INFO - '_': '/tools/buildbot/bin/python'} 07:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:23 INFO - Downloading/unpacking psutil>=0.7.1 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:25 INFO - Installing collected packages: psutil 07:38:25 INFO - Running setup.py install for psutil 07:38:25 INFO - building 'psutil._psutil_linux' extension 07:38:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:38:25 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 07:38:25 INFO - building 'psutil._psutil_posix' extension 07:38:25 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 07:38:25 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 07:38:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:26 INFO - Successfully installed psutil 07:38:26 INFO - Cleaning up... 07:38:26 INFO - Return code: 0 07:38:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:38:26 INFO - Using env: {'DISPLAY': ':0', 07:38:26 INFO - 'HOME': '/home/cltbld', 07:38:26 INFO - 'LANG': 'en_US.UTF-8', 07:38:26 INFO - 'LANGUAGE': 'en_US:en', 07:38:26 INFO - 'LOGNAME': 'cltbld', 07:38:26 INFO - 'MAIL': '/var/mail/cltbld', 07:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:26 INFO - 'MOZ_NO_REMOTE': '1', 07:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:26 INFO - 'NO_EM_RESTART': '1', 07:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:26 INFO - 'PWD': '/builds/slave/test', 07:38:26 INFO - 'SHELL': '/bin/bash', 07:38:26 INFO - 'SHLVL': '1', 07:38:26 INFO - 'TERM': 'linux', 07:38:26 INFO - 'TMOUT': '86400', 07:38:26 INFO - 'USER': 'cltbld', 07:38:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:26 INFO - '_': '/tools/buildbot/bin/python'} 07:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:38:28 INFO - Installing collected packages: mozsystemmonitor 07:38:28 INFO - Running setup.py install for mozsystemmonitor 07:38:28 INFO - Successfully installed mozsystemmonitor 07:38:28 INFO - Cleaning up... 07:38:28 INFO - Return code: 0 07:38:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:28 INFO - Using env: {'DISPLAY': ':0', 07:38:28 INFO - 'HOME': '/home/cltbld', 07:38:28 INFO - 'LANG': 'en_US.UTF-8', 07:38:28 INFO - 'LANGUAGE': 'en_US:en', 07:38:28 INFO - 'LOGNAME': 'cltbld', 07:38:28 INFO - 'MAIL': '/var/mail/cltbld', 07:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:28 INFO - 'MOZ_NO_REMOTE': '1', 07:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:28 INFO - 'NO_EM_RESTART': '1', 07:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:28 INFO - 'PWD': '/builds/slave/test', 07:38:28 INFO - 'SHELL': '/bin/bash', 07:38:28 INFO - 'SHLVL': '1', 07:38:28 INFO - 'TERM': 'linux', 07:38:28 INFO - 'TMOUT': '86400', 07:38:28 INFO - 'USER': 'cltbld', 07:38:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:28 INFO - '_': '/tools/buildbot/bin/python'} 07:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:30 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 07:38:30 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 07:38:30 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 07:38:30 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 07:38:30 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 07:38:30 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 07:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:31 INFO - Downloading docopt-0.6.1.tar.gz 07:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:31 INFO - Running setup.py install for blobuploader 07:38:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:31 INFO - Running setup.py install for requests 07:38:31 INFO - Running setup.py install for docopt 07:38:31 INFO - Successfully installed blobuploader requests docopt 07:38:31 INFO - Cleaning up... 07:38:31 INFO - Return code: 0 07:38:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:31 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 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:31 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 07:38:31 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 07:38:31 INFO - Using env: {'DISPLAY': ':0', 07:38:31 INFO - 'HOME': '/home/cltbld', 07:38:31 INFO - 'LANG': 'en_US.UTF-8', 07:38:31 INFO - 'LANGUAGE': 'en_US:en', 07:38:31 INFO - 'LOGNAME': 'cltbld', 07:38:31 INFO - 'MAIL': '/var/mail/cltbld', 07:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:31 INFO - 'MOZ_NO_REMOTE': '1', 07:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:31 INFO - 'NO_EM_RESTART': '1', 07:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:31 INFO - 'PWD': '/builds/slave/test', 07:38:31 INFO - 'SHELL': '/bin/bash', 07:38:31 INFO - 'SHLVL': '1', 07:38:31 INFO - 'TERM': 'linux', 07:38:31 INFO - 'TMOUT': '86400', 07:38:31 INFO - 'USER': 'cltbld', 07:38:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:31 INFO - '_': '/tools/buildbot/bin/python'} 07:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:32 INFO - Running setup.py (path:/tmp/pip-BF8bSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:32 INFO - Running setup.py (path:/tmp/pip-h6qnD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:32 INFO - Running setup.py (path:/tmp/pip-aa17FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:32 INFO - Running setup.py (path:/tmp/pip-7EALzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:32 INFO - Running setup.py (path:/tmp/pip-aYKxUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:32 INFO - Running setup.py (path:/tmp/pip-qRDG0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:32 INFO - Running setup.py (path:/tmp/pip-vfsBQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:32 INFO - Running setup.py (path:/tmp/pip-U_J8H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:32 INFO - Running setup.py (path:/tmp/pip-U7QjTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:32 INFO - Running setup.py (path:/tmp/pip-R0I1tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:32 INFO - Running setup.py (path:/tmp/pip-OJflQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:32 INFO - Running setup.py (path:/tmp/pip-PHRsoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:32 INFO - Running setup.py (path:/tmp/pip-DBybYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:33 INFO - Running setup.py (path:/tmp/pip-zQsC5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:33 INFO - Running setup.py (path:/tmp/pip-wQmxGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:33 INFO - Running setup.py (path:/tmp/pip-8DhfE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:33 INFO - Running setup.py (path:/tmp/pip-QlUbUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:33 INFO - Running setup.py install for manifestparser 07:38:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:33 INFO - Running setup.py install for mozcrash 07:38:33 INFO - Running setup.py install for mozdebug 07:38:33 INFO - Running setup.py install for mozdevice 07:38:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:33 INFO - Running setup.py install for mozfile 07:38:33 INFO - Running setup.py install for mozhttpd 07:38:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:33 INFO - Running setup.py install for mozinfo 07:38:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozInstall 07:38:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozleak 07:38:34 INFO - Running setup.py install for mozlog 07:38:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for moznetwork 07:38:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozprocess 07:38:34 INFO - Running setup.py install for mozprofile 07:38:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozrunner 07:38:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozscreenshot 07:38:34 INFO - Running setup.py install for moztest 07:38:35 INFO - Running setup.py install for mozversion 07:38:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:35 INFO - Cleaning up... 07:38:35 INFO - Return code: 0 07:38:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:38:35 INFO - Using env: {'DISPLAY': ':0', 07:38:35 INFO - 'HOME': '/home/cltbld', 07:38:35 INFO - 'LANG': 'en_US.UTF-8', 07:38:35 INFO - 'LANGUAGE': 'en_US:en', 07:38:35 INFO - 'LOGNAME': 'cltbld', 07:38:35 INFO - 'MAIL': '/var/mail/cltbld', 07:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:35 INFO - 'MOZ_NO_REMOTE': '1', 07:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:35 INFO - 'NO_EM_RESTART': '1', 07:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:35 INFO - 'PWD': '/builds/slave/test', 07:38:35 INFO - 'SHELL': '/bin/bash', 07:38:35 INFO - 'SHLVL': '1', 07:38:35 INFO - 'TERM': 'linux', 07:38:35 INFO - 'TMOUT': '86400', 07:38:35 INFO - 'USER': 'cltbld', 07:38:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:35 INFO - '_': '/tools/buildbot/bin/python'} 07:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:35 INFO - Running setup.py (path:/tmp/pip-3SQh3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:35 INFO - Running setup.py (path:/tmp/pip-aOdJIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:35 INFO - Running setup.py (path:/tmp/pip-_JeYsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:35 INFO - Running setup.py (path:/tmp/pip-pZTStD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:35 INFO - Running setup.py (path:/tmp/pip-HeOByC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:35 INFO - Running setup.py (path:/tmp/pip-_0AstQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:35 INFO - Running setup.py (path:/tmp/pip-fxMv1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:35 INFO - Running setup.py (path:/tmp/pip-Ok642G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:35 INFO - Running setup.py (path:/tmp/pip-taVWt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:35 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)) 07:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:35 INFO - Running setup.py (path:/tmp/pip-maDAaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:36 INFO - Running setup.py (path:/tmp/pip-LZ2Occ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:36 INFO - Running setup.py (path:/tmp/pip-lRM6Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:36 INFO - Running setup.py (path:/tmp/pip-zBRXSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:36 INFO - Running setup.py (path:/tmp/pip-qrFcrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:36 INFO - Running setup.py (path:/tmp/pip-_md6vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:36 INFO - Running setup.py (path:/tmp/pip-PO7ZXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:36 INFO - Running setup.py (path:/tmp/pip-incyNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:36 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)) 07:38:36 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)) 07:38:36 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)) 07:38:36 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)) 07:38:36 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)) 07:38:36 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)) 07:38:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:38 INFO - Downloading blessings-1.6.tar.gz 07:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:38 INFO - Installing collected packages: blessings 07:38:38 INFO - Running setup.py install for blessings 07:38:38 INFO - Successfully installed blessings 07:38:38 INFO - Cleaning up... 07:38:38 INFO - Return code: 0 07:38:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:38 INFO - Reading from file tmpfile_stdout 07:38:38 INFO - Current package versions: 07:38:38 INFO - argparse == 1.2.1 07:38:38 INFO - blessings == 1.6 07:38:38 INFO - blobuploader == 1.2.4 07:38:38 INFO - docopt == 0.6.1 07:38:38 INFO - manifestparser == 1.1 07:38:38 INFO - mozInstall == 1.12 07:38:38 INFO - mozcrash == 0.17 07:38:38 INFO - mozdebug == 0.1 07:38:38 INFO - mozdevice == 0.48 07:38:38 INFO - mozfile == 1.2 07:38:38 INFO - mozhttpd == 0.7 07:38:38 INFO - mozinfo == 0.9 07:38:38 INFO - mozleak == 0.1 07:38:38 INFO - mozlog == 3.1 07:38:38 INFO - moznetwork == 0.27 07:38:38 INFO - mozprocess == 0.22 07:38:38 INFO - mozprofile == 0.28 07:38:38 INFO - mozrunner == 6.11 07:38:38 INFO - mozscreenshot == 0.1 07:38:38 INFO - mozsystemmonitor == 0.0 07:38:38 INFO - moztest == 0.7 07:38:38 INFO - mozversion == 1.4 07:38:38 INFO - psutil == 3.1.1 07:38:38 INFO - requests == 1.2.3 07:38:38 INFO - wsgiref == 0.1.2 07:38:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:38 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 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:38 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 07:38:38 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 07:38:38 INFO - Using env: {'DISPLAY': ':0', 07:38:38 INFO - 'HOME': '/home/cltbld', 07:38:38 INFO - 'LANG': 'en_US.UTF-8', 07:38:38 INFO - 'LANGUAGE': 'en_US:en', 07:38:38 INFO - 'LOGNAME': 'cltbld', 07:38:38 INFO - 'MAIL': '/var/mail/cltbld', 07:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:38 INFO - 'MOZ_NO_REMOTE': '1', 07:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:38 INFO - 'NO_EM_RESTART': '1', 07:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:38 INFO - 'PWD': '/builds/slave/test', 07:38:38 INFO - 'SHELL': '/bin/bash', 07:38:38 INFO - 'SHLVL': '1', 07:38:38 INFO - 'TERM': 'linux', 07:38:38 INFO - 'TMOUT': '86400', 07:38:38 INFO - 'USER': 'cltbld', 07:38:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:38 INFO - '_': '/tools/buildbot/bin/python'} 07:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:38:39 INFO - Cleaning up... 07:38:39 INFO - Return code: 0 07:38:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:38:39 INFO - Using env: {'DISPLAY': ':0', 07:38:39 INFO - 'HOME': '/home/cltbld', 07:38:39 INFO - 'LANG': 'en_US.UTF-8', 07:38:39 INFO - 'LANGUAGE': 'en_US:en', 07:38:39 INFO - 'LOGNAME': 'cltbld', 07:38:39 INFO - 'MAIL': '/var/mail/cltbld', 07:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:39 INFO - 'MOZ_NO_REMOTE': '1', 07:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:39 INFO - 'NO_EM_RESTART': '1', 07:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:39 INFO - 'PWD': '/builds/slave/test', 07:38:39 INFO - 'SHELL': '/bin/bash', 07:38:39 INFO - 'SHLVL': '1', 07:38:39 INFO - 'TERM': 'linux', 07:38:39 INFO - 'TMOUT': '86400', 07:38:39 INFO - 'USER': 'cltbld', 07:38:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:39 INFO - '_': '/tools/buildbot/bin/python'} 07:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:39 INFO - Downloading/unpacking jsonschema 07:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:41 INFO - Downloading/unpacking functools32 (from jsonschema) 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:41 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:41 INFO - warning: no files found matching '*.txt' 07:38:41 INFO - no previously-included directories found matching 'build' 07:38:41 INFO - no previously-included directories found matching 'dist' 07:38:41 INFO - no previously-included directories found matching '.git*' 07:38:41 INFO - Installing collected packages: jsonschema, functools32 07:38:41 INFO - Running setup.py install for functools32 07:38:41 INFO - warning: no files found matching '*.txt' 07:38:41 INFO - no previously-included directories found matching 'build' 07:38:41 INFO - no previously-included directories found matching 'dist' 07:38:41 INFO - no previously-included directories found matching '.git*' 07:38:41 INFO - Successfully installed jsonschema functools32 07:38:41 INFO - Cleaning up... 07:38:41 INFO - Return code: 0 07:38:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 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 0x7f8f75ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, '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': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', '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 07:38:41 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 07:38:41 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 07:38:41 INFO - Using env: {'DISPLAY': ':0', 07:38:41 INFO - 'HOME': '/home/cltbld', 07:38:41 INFO - 'LANG': 'en_US.UTF-8', 07:38:41 INFO - 'LANGUAGE': 'en_US:en', 07:38:41 INFO - 'LOGNAME': 'cltbld', 07:38:41 INFO - 'MAIL': '/var/mail/cltbld', 07:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:41 INFO - 'MOZ_NO_REMOTE': '1', 07:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:41 INFO - 'NO_EM_RESTART': '1', 07:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:41 INFO - 'PWD': '/builds/slave/test', 07:38:41 INFO - 'SHELL': '/bin/bash', 07:38:41 INFO - 'SHLVL': '1', 07:38:41 INFO - 'TERM': 'linux', 07:38:41 INFO - 'TMOUT': '86400', 07:38:41 INFO - 'USER': 'cltbld', 07:38:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:41 INFO - '_': '/tools/buildbot/bin/python'} 07:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:41 INFO - Downloading/unpacking flake8 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38:43 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 07:38:43 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 07:38:43 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 07:38:43 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 07:38:43 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 07:38:43 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 07:38:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:44 INFO - no previously-included directories found matching 'docs/_build' 07:38:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:44 INFO - Running setup.py install for pep8 07:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:44 INFO - no previously-included directories found matching 'docs/_build' 07:38:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:44 INFO - Cleaning up... 07:38:44 INFO - Return code: 0 07:38:44 INFO - Running post-action listener: _resource_record_post_action 07:38:44 INFO - Running post-action listener: _start_resource_monitoring 07:38:44 INFO - Starting resource monitoring. 07:38:44 INFO - ##### 07:38:44 INFO - ##### Running install step. 07:38:44 INFO - ##### 07:38:44 INFO - Running pre-action listener: _resource_record_pre_action 07:38:44 INFO - Running main action method: install 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:44 INFO - Reading from file tmpfile_stdout 07:38:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:45 INFO - Reading from file tmpfile_stdout 07:38:45 INFO - Output received: 07:38:45 INFO - Usage: mozinstall [options] installer 07:38:45 INFO - Options: 07:38:45 INFO - -h, --help show this help message and exit 07:38:45 INFO - -d DEST, --destination=DEST 07:38:45 INFO - Directory to install application into. [default: 07:38:45 INFO - "/builds/slave/test"] 07:38:45 INFO - --app=APP Application being installed. [default: firefox] 07:38:45 INFO - mkdir: /builds/slave/test/build/application 07:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:39:00 INFO - Reading from file tmpfile_stdout 07:39:00 INFO - Output received: 07:39:00 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:00 INFO - Running post-action listener: _resource_record_post_action 07:39:00 INFO - ##### 07:39:00 INFO - ##### Running run-tests step. 07:39:00 INFO - ##### 07:39:00 INFO - Running pre-action listener: _resource_record_pre_action 07:39:00 INFO - Running main action method: run_tests 07:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:00 INFO - Python 2.7.3 07:39:00 INFO - Return code: 0 07:39:00 INFO - grabbing minidump binary from tooltool 07:39: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')]} 07:39:00 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 0x263f410>, '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 0x2640310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26407a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:00 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 07:39:00 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 07:39:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:00 INFO - Return code: 0 07:39:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:39:01 INFO - Return code: 0 07:39:01 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/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 07:39:01 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/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 07:39:01 INFO - Using env: {'DISPLAY': ':0', 07:39:01 INFO - 'HOME': '/home/cltbld', 07:39:01 INFO - 'LANG': 'en_US.UTF-8', 07:39:01 INFO - 'LANGUAGE': 'en_US:en', 07:39:01 INFO - 'LOGNAME': 'cltbld', 07:39:01 INFO - 'MAIL': '/var/mail/cltbld', 07:39:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:01 INFO - 'MOZ_NO_REMOTE': '1', 07:39:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:01 INFO - 'NO_EM_RESTART': '1', 07:39:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:01 INFO - 'PWD': '/builds/slave/test', 07:39:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:01 INFO - 'SHELL': '/bin/bash', 07:39:01 INFO - 'SHLVL': '1', 07:39:01 INFO - 'TERM': 'linux', 07:39:01 INFO - 'TMOUT': '86400', 07:39:01 INFO - 'USER': 'cltbld', 07:39:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212', 07:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:01 INFO - '_': '/tools/buildbot/bin/python'} 07:39:01 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/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 07:39:01 INFO - mozversion application_buildid: 20160423070046 07:39:01 INFO - mozversion application_changeset: 1aabbe445e730853e83e9585d888fe548320226a 07:39:01 INFO - mozversion application_display_name: Nightly 07:39:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:01 INFO - mozversion application_name: Firefox 07:39:01 INFO - mozversion application_remotingname: firefox 07:39:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:39:01 INFO - mozversion application_vendor: Mozilla 07:39:01 INFO - mozversion application_version: 48.0a1 07:39:01 INFO - mozversion platform_buildid: 20160423070046 07:39:01 INFO - mozversion platform_changeset: 1aabbe445e730853e83e9585d888fe548320226a 07:39:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:39:01 INFO - mozversion platform_version: 48.0a1 07:39:01 INFO - using testdate: 1461422341 07:39:01 INFO - actual date: 1461422341 07:39:01 INFO - starting webserver on 'localhost:53373' 07:39:01 INFO - SUITE-START | Running 2 tests 07:39:01 INFO - TEST-START | dromaeo_css 07:39:01 INFO - operating with platform_type : linux_ 07:39:01 INFO - Initialising browser for dromaeo_css test... 07:39:02 INFO - TEST-INFO | started process 10724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUrv69F/profile http://localhost:53373/getInfo.html) 07:39:06 INFO - PROCESS | 10724 | __metrics Screen width/height:1600/1200 07:39:06 INFO - PROCESS | 10724 | colorDepth:24 07:39:06 INFO - PROCESS | 10724 | Browser inner width/height: 1024/697 07:39:06 INFO - PROCESS | 10724 | __metrics 07:39:07 ERROR - PROCESS | 10724 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:39:08 INFO - TEST-INFO | 10724: exit 0 07:39:08 INFO - Browser initialized. 07:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:08 INFO - TEST-INFO | started process 10805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUrv69F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:20 INFO - PROCESS | 10805 | RSS: Main: 155963392 07:39:20 INFO - PROCESS | 10805 | 07:40:11 INFO - PROCESS | 10805 | 1461422411517 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] 07:42:23 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53373/tests/dromaeo/cssquery-ext.html) 07:42:24 INFO - PROCESS | 10805 | RSS: Main: 286818304 07:42:24 INFO - PROCESS | 10805 | 07:45:26 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-ext.html (next: http://localhost:53373/tests/dromaeo/cssquery-jquery.html) 07:45:27 INFO - PROCESS | 10805 | RSS: Main: 242409472 07:45:27 INFO - PROCESS | 10805 | 07:48:29 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53373/tests/dromaeo/cssquery-mootools.html) 07:48:30 INFO - PROCESS | 10805 | RSS: Main: 243036160 07:48:30 INFO - PROCESS | 10805 | 07:51:32 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53373/tests/dromaeo/cssquery-prototype.html) 07:51:33 INFO - PROCESS | 10805 | RSS: Main: 242880512 07:51:33 INFO - PROCESS | 10805 | 07:54:36 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53373/tests/dromaeo/cssquery-yui.html) 07:54:36 INFO - PROCESS | 10805 | RSS: Main: 215420928 07:54:36 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | Cycle 1(1): loaded http://localhost:53373/tests/dromaeo/cssquery-yui.html (next: http://localhost:53373/tests/dromaeo/cssquery-dojo.html) 07:57:39 INFO - PROCESS | 10805 | RSS: Main: 288591872 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | __start_tp_report 07:57:39 INFO - PROCESS | 10805 | _x_x_mozilla_page_load 07:57:39 INFO - PROCESS | 10805 | _x_x_mozilla_page_load_details 07:57:39 INFO - PROCESS | 10805 | |i|pagename|runs| 07:57:39 INFO - PROCESS | 10805 | |0;dojo.html;2612.725663805301;2665.0539058634195;2677.986610066949;2685.248130523452;2705.864706764661;4525.705829121113;4583.243764778816;4688.835890743825;4695.037517308952;4732.905341893164;4618.838340658078;4713.34013238147;4719.315699223611;4745.288206768986;4746.881327966803;4315.913681726363;4319.784010799463;4353.064091220387;4383.320585309282;4467.642588592905;4383.057642606839;4428.911421771562;4473.865784026484;4478.664100192498;4487.46150461945;4264.7227930184745;4337.869863904057;4338.674599405057;4377.671674624416;4389;4236.597523235288;4301.956980430187;4365.279728844736;4369.410129632491;4385.693001489897;4253.425787518676;4255;4255.446791917031;4258.297380932174;4297.914041719148;4559.316102584606;4571.405717256735;4574.405327307462;4579.702319349231;4593.977030114861;4936.284238785392;5014.122528557525;5108.438071812097;5109.386873575195;5109.4379618241965;5052.747362631891;5078.64449488536;5080.79676812927;5095.745212739348;5099.311592934981;4645.861763867806;4729.172394830891;4750.144973904661;4755.025219829927;4787.114383839001;5142.2286657001005;5159.74201289934;5166.3025491558155;5215.634905556574;5225.16397376418;4952.653314268039;4957.7273249971595;4959.082569724613;4960.404751429852;5010.949890501121;4933.876653083702;4979.228219625964;5036.748162591855;5038.294638750578;5042.39491261051;5023.497650234947;5040.546350828443;5046.1169295373165;5074.441811400743;5096.464871188472;4991.301217829507;4999.600031997432;5007.899842003212;5030.245463180479;5051.419086804991;4223.366495025709;4292.377605247221;4297.892552686208;4359.934600980988;4395.7142785718825;3739.569949455793;3761.887143385648;3774.452704357853;3779.7354185206773;3781.962180378216;4239.109786944715;4278.593533614302;4280;4326.048269380732;4391.473023237232;4981.37732783402;4981.501849814989;4982.60139188864;4983.878627308826;5034.823781167642;4321.092570560218;4327.026419055687;4329.242382583036;4372.060007098489;4372.737635741865;4341.891452713644;4532;4548.613367863769;4552.203364411214;4593.173228818845;4810.5670489656095;4812;4814.422269327633;4835.057163853015;4844.806207751792;5034.974825125851;5040.36995375578;5042.84871453857;5043.293938848491;5102.897942041212;4567.63458923292;4778.952210477851;4785.665003449725;4850.902981940412;4869.853904382874;4995.875103122451;5000;5008.248762685626;5011.674241174312;5059.924101138412;5076.82231121909;5077.263796749525;5083.415407228068;5091.312672789126;5092.821751238689;4807.423109226916;4831.95168048315;4883.731394773322;4930.186519224431;4930.802767889388;4902.803887844446;4927.1377508935075;4927.260910863256;4932.524897363995;4975.726335051607;4691.437027556715;4854.393200849894;4866.756662166807;4913.017396520639;4917.188663870421;4887.266909963534;4896.559309662148;4897.730624815669;4902.289168070539;4905.2151655734915;4773.093112308789;4799.112164249625;4817.78319975609;4877.780499877585;4913.459519452786 07:57:39 INFO - PROCESS | 10805 | |1;ext.html;560.8878224355127;600.4445887554012;606.5875204860696;613.6624856329018;617.3486971245336;26652.200433986985;33837.323253534916;34212.99999999997;34304.65695343046;34336.31327373451;35913.820430897875;36567.4514882277;36592.817035914784;36636.63363366365;36675.083122921875;7559.659815308324;7737.342325902305;7746.49647772893;7754.8449031019345;7756.573388463632;7539.924600754004;7667.5782831944225;7667.808304792369;7671.731489397872;7835.138134805167;7790.6883724651225;7871.409644276673;7875;7878;7878.842423151534;7788.6105694715325;7794.72718454857;7835.804104897366;7850.136484986619;7857.921420785776;7724.7682569523;7836.647350869224;7839.294463498256;7848.607569621496;7854.214578542157;36995.630043699486;37521.624783752086;37542.62457375446;37578.24843503142;37590.43614345787;3057.969420305813;3058.510638297884;3410.7100896423585;3598.5142005829402;3621.3481573316794;27858.721412785817;28296;28323.57514637282;28337.716622833716;28486.572701409495;3500.824958752052;3578.6421357864006;3613.385724426854;3654.3604869148057;3733.1227161617;230329;230906;231703;231707;232215;50582;50971.49028509742;51501;51611.19360822353;51667.483325166264;55163;55266.44733552694;55363.72318138384;55422.44577554253;55448;13917.095388799695;14066.578002659937;14082.225477598831;14124.50564230247;14150.85849141516;10931.344119352865;11004.39475828821;11004.834927476095;11006.724831879266;11012.724681882857;14963.625909352353;16127.193640317937;16371.672566548603;16410.17949102564;16428;5024.723640199824;6006.309274433496;6044.969775151096;6086.360932102066;6340.397662222082;922.3220932614523;928.3223247029706;962.2302158273353;990.8464188050864;1004.2016596805557;26347.604785928226;27741.445171096868;28324.84267305988;28813.855930720212;28817.56773648397;939.389396892012;996.496769131584;1021.4841505039907;1042.3381152967768;1097.2483848563759;14400.927995359956;14672.853271467362;14944.402223910922;15088.849111508744;15261.160636165117;350074;353201;355649;357566;358325;47968;48458;48469;48542.02915941732;48555.271670924965;1032.3805716569998;1172.7068232941765;1218.5674085699627;1270.7966725323904;1376.4769387632637;24035.409888420676;27219;27352.452950941268;28145.43709125847;28312.150635480968;38527.807360964136;38608.80695596504;38870.6112938867;39045.21909561849;39082.41376379413;237339;237535;237579;238204;238310;31598.36803263876;32712.672873270963;36659.63340366669;37518;37519.74881507118;35602.287954241285;36077.63922360848;36212.27575448529;36279.81860090682;36910.446343304335;30405.84797076089;30968;31034.68965310318;31351.372972540878;31806.6819331813;31578;33999.49000764941;34105.65894341025;34121.82939085289;34253.828730856185;34303.4854477178;34511.30977380388;34912.65087349094;35021.64978350184;35138.12154696153;30255.09234722962;30851.537226941164;31021.224469388446;31184.844075780384;31220;23863.164789232294;24492;24555.403898746525;24637.50724985526;24821.255362339158 07:57:39 INFO - PROCESS | 10805 | |2;jquery.html;365.36791350962835;373.2907475795988;394.9585293544178;395.9425883246929;398.74480332587166;15671.60820979476;17093;17369.392071277507;17509;17576.472705818815;16235.431759888406;16946.661066778688;17140.159514994917;17365.044922529254;17400.21699023544;5117.744112794373;5236.057509648262;5270.92093618596;5273.604479664022;5289.523942845143;3707.7589956652732;3954.110325176841;5768.394318596529;6119.3880611938675;6126.571140020201;5880.353161152269;5998.730057147439;6047.3650266722025;6075.513958883279;6084.695765211722;5783.5951483396175;5885.264341957255;5912.113183022538;5921.0230311998685;5924.08176732605;3351.447011243142;3562.5190599269026;3565.8573657053685;3566.3937130687846;5053.4946505349535;19584.70622940657;19797.40607781769;19916.900415497974;20948.266810661553;20993;1865.822746839048;1999.3901859932714;2059.9588008239903;2136.1241890824845;2566.910158144456;12867.806982895265;13169.86830131696;13237.470501179941;13366.465341386333;13652.317384130754;1826.7351234071118;1834.1287888253107;1855.2857149997212;1869.140195510067;1910.646530391868;58795.70602146962;62342;63374.04938925966;63684.36315636831;65436;10044.397336159855;10208;10312.27814053009;10327.84508232377;10453.111485523816;14211.147331159957;14273.143611383142;14305;14340.856591434162;14368.640783980483;6380.042993550912;6386.265579458329;6551.377619126175;6585.835354116185;6644.036614690939;5764.827055188267;5783.681897495594;5900.291964964232;5954.8809023819285;5960.552958528127;4406.515283318897;4448.866534003985;4484.910301793946;4565;4566.725996440225;1749.2827940544316;1813.6463389638893;1816.8909865408118;1880.4117952196596;1903.3338331584112;404.7065877238978;406.28899426004494;890.9688160914337;914.9451032938046;975.9316847820585;10372.844407333896;10536.315139515908;10610.893891061145;10693.786124277627;10819;436.5832872329312;437.49032377280747;448.9842855500042;451.09105153116496;462.3226972485325;5677.744501497443;5901.380355062656;5943.55423343251;5953.613015154001;5956.344802071769;410801;412969.7406051862;418048;424855;427885;82552.58723706462;83250;83319.5834020826;83320.16679833124;84482;451.33202859767727;454.82034596334927;456.3474231848489;458.2965148497041;459.46701825882485;9797.363171393836;9854.55654495535;10171.54228059754;10224.846627300745;10347.741306467398;33414.665853341154;33711.3257734839;34243.65756342404;34630.653693462744;35652.28695426129;46002.769986149855;48222.758886205345;51484.485155149465;51804;52029;7548.509346892434;7810.843783124419;7825.726099586487;7947.721829735931;8110;6678.49911256648;8795.736127916172;10610.575576977144;11046.392448415092;11373.715657108638;7502.837060255669;9077.273818094669;9802.803943921224;10370.274080814572;10396.896031039592;10390;10468.267221294436;10509.579616815548;10614;10639.787204255717;5663.235463212413;7800.531968081933;10261.409481530374;10635.840462392916;10792.730181745519;7647.158812530506;7873.173316801883;7887.723929662434;7931.960340198493;7976.401769867167;7909.564973926489;9588;10072.798544029225;10217.846732298873;10591.099756520782 07:57:39 INFO - PROCESS | 10805 | |3;mootools.html;1265.8417697787777;1450.06470826317;1477.674911519466;1615.6526346835435;1780.5281600375902;6768.729250829961;7634.465587408884;7822.921770782291;7847.058352997648;7867.645955931983;7549.509281896687;7713.074431068279;7724;7730.226977302267;7732.342750866169;1892.0634286028435;2131.765505794361;2179.4333473296897;2188.413400284797;2221.5112675211426;2161.7513985891587;2177.912883484659;2183.530540933699;2198.835087368454;2205.0297868937696;2119.5654890747437;2132.115172203534;2172.9239476618322;2178.8583742056794;2179.3788770200495;1843.4561804267705;2078.615456140619;2110.598986192626;2134.445044288481;2138.5081431270737;2101.7057611934342;2106.7050612914204;2125.0649714125734;2126.9787302126933;2128.425325162213;7579.242075792376;7593.924060759432;7634.4655874088285;7644.082710074771;7648.043994500687;4460.50934397216;4616.7691615419435;4618.5381461853885;4620.930686039712;4639.86080417588;3000.5949196858364;3026.4098500792134;3078.6459557150765;3117.7973431726864;3138.152698771342;1005.9647912323034;1025.5026312238558;1029.510982283417;1679.5717092141547;1701.481048280274;10371.118454931264;10461.215408844291;10488.790224195549;10492.895071049268;10495.580176792919;3941.4087886816633;4114.855980040684;4214.262504061777;4240.512341080754;4242.809073591696;8200.179982001871;8251.051129120107;8266.628001739937;8272.214139656722;8301.8339633207;4549.5905368517;4556.6126879215635;4557.225271703818;4557.361969324297;4589.036302376471;3715.888523344304;4231.703780735381;4333.891652708645;4342.32693932441;4354.629856462237;3438.673326034023;3520.4543295789194;3554.111472131967;3573.10672331917;3584.6415358463946;1058.343826827372;1080.103514083309;1082.426314053553;1088.7387027113593;1090.86909570852;757.4243574883128;798.8402319536116;813.1624426840364;857.7341024282492;868.7871471489525;5241.711705856214;5321.201819727072;5425.104857698515;5529.391766905637;5612.719364031782;420.3106904676333;420.3820384035463;421.09464651000593;429.2830972276306;431.1592394830094;3446.2418267981;3475.165960169541;3485.7734247273847;3526.5415495985358;3589.120665436985;9327.626894924128;9816.65641702537;9916.950415247878;9931.453770042717;9941.602335906628;9526.90473095274;9543.809123817486;9689.41863488193;9707.271954603433;9716.222702183808;6845.520813543004;7255.4921155518605;7416.962915185498;7470.103587569418;7482.176960534337;5411.242426060276;5423;5488.396276409671;5507.173923911445;5605.047141985954;8676.132386761274;8685.305175585812;8808.911910881065;8859.246964007874;8901.154390332907;8509.74470765878;8767.693130740394;8797.780055498664;8885.555722213992;8937.28501719848;6080.513558915364;6283.7800676976085;6296.6851657417865;6564.113844630913;6678.899816502853;6732.966335168293;7258;7506.211847755907;7533.1336896257635;7538.509996850187;6498.545101842826;6765.830854228487;6782.593044417351;6875.278095799869;6942.236354000955;6673.9332606673315;6683.899741503784;6750.763723269662;6826.317368263134;6912.516123871482;6388;6429.935700642934;6442.098106265033;6448.548601597843;6466.41802237782;4741.075490279362;4776.21192503233;4858.319835223142;4873.780679869344;4909.337239472626;4740.857774266778;4752.120857641347;4791.161546729378;4804.975975120102;4902.9019419610695 07:57:39 INFO - PROCESS | 10805 | |4;prototype.html;319.8656564243018;321.5241442664856;323.8898774416698;326.2707847959808;331.19023986353346;5074;5131.153359695646;5147.613928955329;5153.81961631343;5184.585233181346;5049.596032317415;5058.873528161797;5077.162268225738;5083.5933125349975;5098.668586541872;3795.601461846508;3872.67082298005;3917.8628747993826;3985.302572049894;4003.6997225208224;3969.741966772165;3992.8802135935825;3999.0802115513447;4014.635024091808;4015.9799201003952;3758.285925674113;3960.425738267964;3968.4840970673918;3984.820683069269;3995.680345572347;3821.159344944108;3940.1134744682217;3941.625545573166;3949.6050394960416;3967.7222594418404;3537.840797164108;3539.292141571696;3545.911352216215;3547.5565554305713;3551.076720052805;4800.231962885957;4855.68438051529;4870.756462176877;4887.75561221941;4894.583960363373;4222.374385861434;4452.465704115494;4467.530909254514;4493.9101217975785;4586.289125185602;5239.73801309933;5294.92057619136;5295.040834891115;5300.787968481256;5300.946990530084;3710.8144592770523;3714.888553343404;3727.925441491182;3728.254349130185;3735.9912823537493;5307.832276899076;5519.917201241985;5582.33012038558;5591.993441180586;5624.606277560572;3862.4592557042038;3871.4967054283325;3878.631530004645;3881.340172170738;3883.9611603884164;3926.70549708773;3927.1346110597237;3945.191235796712;3946.1121247719034;3947.7236593438756;4361.542038086019;4501.977490112528;4508.639308855284;4508.729476231437;4523.5250298718165;5267.183586544092;5270.708676374236;5304.575633949275;5322.175062865262;5338.786448542015;1409.2319685771279;1427.1508452470764;1429.5568373804153;1429.7283516131902;1437.0874494695734;936.4989730494153;985.4136788610765;988.5403287471361;998.1415982255255;1017.7150397888603;4595.379623750818;4599.72401655895;4599.816007359735;4605.700629459075;4623.075384922961;5397.487238712316;5406.243125962368;5420.214068959979;5426.674399535961;5435.211894275308;4499.370088187657;4579.862604121881;4586.908261834811;4603.516630753789;4694;2922.1963959911195;2942.7204415580914;2957.4233024560435;2957.8816847325866;2962.1113665900143;5231.973840130851;5238.869028274324;5240.349289973646;5248.868778280574;5249.186376111708;5492.69790161537;5652.434756524314;5657.830265091971;5660.037793575102;5727;5224.660397074178;5229.267902493654;5256.1327380982475;5259.8422047338645;5260.842174734764;5453.372862120748;5579.051561234681;5579.442055794388;5580.497755202051;5587.55299576041;5430.782768689208;5434.75543600531;5441.428649991693;5442.782288708566;5463.743339032125;5198;5208.4270730220405;5258.842234732964;5274.261603375454;5277.973610131925;3857.922841543097;3915.7063220258024;3933.783641899723;3941.9605803941595;3945.585713500041;5416.9729151353995;5480.232767412645;5516.420775818642;5558;5560.138178582326;5343.62594618373;5352.518273355417;5359.839204823861;5360.812371566976;5375.784968601369;5173.81891633791;5350.411454739898;5353.892922141613;5354.8487075279;5372.113601255749;5011.223260394645;5271.1302635064785;5275.287836142072;5288.788448462018;5294.152935530451;5202;5271.973640131775;5281.524662780368;5298.81454149103;5300.893982120258;5248.212768084818;5283.603729720363;5302.496262855023;5303;5305 07:57:39 INFO - PROCESS | 10805 | |5;yui.html;682.5768023825229;710.3890654037529;710.8507213485171;737.4985010193068;779.1429427629608;11149.331040137597;11637.825432618518;11866.050715942725;11885.762284754299;11907.106966977468;12360.752784944296;12420.130590858644;12427.13010089294;12440.44018019189;12452;811.6347643560392;819.074445876162;825.3644693585935;826.3554427546524;826.6280173921759;651.228294471051;798.5967086621248;824.826786374862;826.277007618334;832.7002279179491;863.5466380150408;865.2558799432514;867.1458613265928;867.600903584352;867.9088695686956;679.296927679849;862.6118246788939;862.7886167888845;862.9439086459391;863.2403484933282;614.5912967876357;631.5736877607596;632.099258556555;632.1781683811073;632.7753647455133;12828.230306181658;12865.614031579067;12870.29213393263;12930.28883411412;12944.87055129446;11875.82186267198;12175.695607609792;12215;12497.062720296015;12834.871651283462;10055.547500362502;10252.538635761333;10267.845982310271;10322.690319290434;10351.430671313075;3345.7657963942534;3350.5141754445467;3389.457686770105;3414.573178352706;3460.0311912664492;46910.5308946913;47092;47110.76444617789;47240.76379618114;47451.28823067691;9344.859827102599;9352.438853668802;9454.14912657864;9479.573419196153;10018.298719089593;17119.14404279806;17171.055591942313;17193.828061719472;17199.828001720074;17219;6462.612243265419;6703.296153903867;6799.524033317621;6843.726250949906;6982.546134501241;3791.298609757204;3904.375299951994;3934.783586902691;3945.4870866787132;4044.8988775280854;2714.538528450168;2765.0322387164333;2772.5009498290096;2774.292555398401;2774.569941659046;501.3382335317419;510;510.82631905152425;511.2484647568069;527.1697077103577;564.9548036157098;649.9122618446544;655.9901601475982;661.1438187547042;661.262692098307;7846.90606995832;8102.716404925799;8114.391420643476;8124.350051995826;8462.915370846336;503.61725088931945;517.5262246461918;637.5728262064428;650.4763665249425;675.7769935921134;3773.1699026214187;3988.1026768977326;4005.939910901339;4022.1955608878343;4027.838886444568;51755;52157.217641735406;52165.7391713039;52216.73891630518;53544.464555353945;39895.20209595792;41364;42609.360859587134;44548.77725611416;45558;32195.35609287801;32560.185995350304;38739.225215495535;38940.610593893696;41609.79195104005;7976.880346794919;8076.313513351431;8108.918910811052;8182.427230094075;8187.918120818716;27581;27735.861320693268;28208.85895570591;28865.42269154647;28983;35774.4633830498;38455.423168653055;38766.092543059945;39264;39384.6061539381;10571.260011799408;10601.787964240826;10676.306040107369;10784.474246957365;10962.397068161008;11573.537058517564;11745.941270293593;11864.466099025738;12010.579629712918;12057.095717821023;10274.33216840903;10570.207234457293;10846;10897.182711296526;10994.175436842428;11090.766674815553;11291.604793832177;11398.886011140114;11738.530458781896;11802.586909458129;10645.201609879136;10651.520681569504;10950.890491094988;11071.335719856834;11460.197786155222;9853.359531630422;9961.302708810603;10134.898651013396;10196.592136314464;10469.790604187721;9365.672201472917;9962.153216976349;10074.496275186359;10099.94950025245;10142.137918277029 07:57:39 INFO - PROCESS | 10805 | __end_tp_report 07:57:39 INFO - PROCESS | 10805 | __start_cc_report 07:57:39 INFO - PROCESS | 10805 | _x_x_mozilla_cycle_collect,1202 07:57:39 INFO - PROCESS | 10805 | __end_cc_report 07:57:39 INFO - PROCESS | 10805 | __startTimestamp1461423459628__endTimestamp 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | ------- Summary: start ------- 07:57:39 INFO - PROCESS | 10805 | Number of tests: 6 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#0] dojo.html Cycles:165 Average:4661.45 Median:4810.57 stddev:483.55 (10.1%) stddev-sans-first:457.55 07:57:39 INFO - PROCESS | 10805 | Values: 2612.7 2665.1 2678.0 2685.2 2705.9 4525.7 4583.2 4688.8 4695.0 4732.9 4618.8 4713.3 4719.3 4745.3 4746.9 4315.9 4319.8 4353.1 4383.3 4467.6 4383.1 4428.9 4473.9 4478.7 4487.5 4264.7 4337.9 4338.7 4377.7 4389.0 4236.6 4302.0 4365.3 4369.4 4385.7 4253.4 4255.0 4255.4 4258.3 4297.9 4559.3 4571.4 4574.4 4579.7 4594.0 4936.3 5014.1 5108.4 5109.4 5109.4 5052.7 5078.6 5080.8 5095.7 5099.3 4645.9 4729.2 4750.1 4755.0 4787.1 5142.2 5159.7 5166.3 5215.6 5225.2 4952.7 4957.7 4959.1 4960.4 5010.9 4933.9 4979.2 5036.7 5038.3 5042.4 5023.5 5040.5 5046.1 5074.4 5096.5 4991.3 4999.6 5007.9 5030.2 5051.4 4223.4 4292.4 4297.9 4359.9 4395.7 3739.6 3761.9 3774.5 3779.7 3782.0 4239.1 4278.6 4280.0 4326.0 4391.5 4981.4 4981.5 4982.6 4983.9 5034.8 4321.1 4327.0 4329.2 4372.1 4372.7 4341.9 4532.0 4548.6 4552.2 4593.2 4810.6 4812.0 4814.4 4835.1 4844.8 5035.0 5040.4 5042.8 5043.3 5102.9 4567.6 4779.0 4785.7 4850.9 4869.9 4995.9 5000.0 5008.2 5011.7 5059.9 5076.8 5077.3 5083.4 5091.3 5092.8 4807.4 4832.0 4883.7 4930.2 4930.8 4902.8 4927.1 4927.3 4932.5 4975.7 4691.4 4854.4 4866.8 4913.0 4917.2 4887.3 4896.6 4897.7 4902.3 4905.2 4773.1 4799.1 4817.8 4877.8 4913.5 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#1] ext.html Cycles:180 Average:42935.44 Median:194169.56 stddev:73608.69 (37.9%) stddev-sans-first:73746.42 07:57:39 INFO - PROCESS | 10805 | Values: 560.9 600.4 606.6 613.7 617.3 26652.2 33837.3 34213.0 34304.7 34336.3 35913.8 36567.5 36592.8 36636.6 36675.1 7559.7 7737.3 7746.5 7754.8 7756.6 7539.9 7667.6 7667.8 7671.7 7835.1 7790.7 7871.4 7875.0 7878.0 7878.8 7788.6 7794.7 7835.8 7850.1 7857.9 7724.8 7836.6 7839.3 7848.6 7854.2 36995.6 37521.6 37542.6 37578.2 37590.4 3058.0 3058.5 3410.7 3598.5 3621.3 27858.7 28296.0 28323.6 28337.7 28486.6 3500.8 3578.6 3613.4 3654.4 3733.1 230329.0 230906.0 231703.0 231707.0 232215.0 50582.0 50971.5 51501.0 51611.2 51667.5 55163.0 55266.4 55363.7 55422.4 55448.0 13917.1 14066.6 14082.2 14124.5 14150.9 10931.3 11004.4 11004.8 11006.7 11012.7 14963.6 16127.2 16371.7 16410.2 16428.0 5024.7 6006.3 6045.0 6086.4 6340.4 922.3 928.3 962.2 990.8 1004.2 26347.6 27741.4 28324.8 28813.9 28817.6 939.4 996.5 1021.5 1042.3 1097.2 14400.9 14672.9 14944.4 15088.8 15261.2 350074.0 353201.0 355649.0 357566.0 358325.0 47968.0 48458.0 48469.0 48542.0 48555.3 1032.4 1172.7 1218.6 1270.8 1376.5 24035.4 27219.0 27352.5 28145.4 28312.2 38527.8 38608.8 38870.6 39045.2 39082.4 237339.0 237535.0 237579.0 238204.0 238310.0 31598.4 32712.7 36659.6 37518.0 37519.7 35602.3 36077.6 36212.3 36279.8 36910.4 30405.8 30968.0 31034.7 31351.4 31806.7 31578.0 33999.5 34105.7 34121.8 34253.8 34303.5 34511.3 34912.7 35021.6 35138.1 30255.1 30851.5 31021.2 31184.8 31220.0 23863.2 24492.0 24555.4 24637.5 24821.3 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#2] jquery.html Cycles:180 Average:24523.40 Median:426370.00 stddev:69117.89 (16.2%) stddev-sans-first:69287.98 07:57:39 INFO - PROCESS | 10805 | Values: 365.4 373.3 395.0 395.9 398.7 15671.6 17093.0 17369.4 17509.0 17576.5 16235.4 16946.7 17140.2 17365.0 17400.2 5117.7 5236.1 5270.9 5273.6 5289.5 3707.8 3954.1 5768.4 6119.4 6126.6 5880.4 5998.7 6047.4 6075.5 6084.7 5783.6 5885.3 5912.1 5921.0 5924.1 3351.4 3562.5 3565.9 3566.4 5053.5 19584.7 19797.4 19916.9 20948.3 20993.0 1865.8 1999.4 2060.0 2136.1 2566.9 12867.8 13169.9 13237.5 13366.5 13652.3 1826.7 1834.1 1855.3 1869.1 1910.6 58795.7 62342.0 63374.0 63684.4 65436.0 10044.4 10208.0 10312.3 10327.8 10453.1 14211.1 14273.1 14305.0 14340.9 14368.6 6380.0 6386.3 6551.4 6585.8 6644.0 5764.8 5783.7 5900.3 5954.9 5960.6 4406.5 4448.9 4484.9 4565.0 4566.7 1749.3 1813.6 1816.9 1880.4 1903.3 404.7 406.3 891.0 914.9 975.9 10372.8 10536.3 10610.9 10693.8 10819.0 436.6 437.5 449.0 451.1 462.3 5677.7 5901.4 5943.6 5953.6 5956.3 410801.0 412969.7 418048.0 424855.0 427885.0 82552.6 83250.0 83319.6 83320.2 84482.0 451.3 454.8 456.3 458.3 459.5 9797.4 9854.6 10171.5 10224.8 10347.7 33414.7 33711.3 34243.7 34630.7 35652.3 46002.8 48222.8 51484.5 51804.0 52029.0 7548.5 7810.8 7825.7 7947.7 8110.0 6678.5 8795.7 10610.6 11046.4 11373.7 7502.8 9077.3 9802.8 10370.3 10396.9 10390.0 10468.3 10509.6 10614.0 10639.8 5663.2 7800.5 10261.4 10635.8 10792.7 7647.2 7873.2 7887.7 7932.0 7976.4 7909.6 9588.0 10072.8 10217.8 10591.1 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#3] mootools.html Cycles:180 Average:5097.25 Median:4831.65 stddev:2830.46 (58.6%) stddev-sans-first:2823.75 07:57:39 INFO - PROCESS | 10805 | Values: 1265.8 1450.1 1477.7 1615.7 1780.5 6768.7 7634.5 7822.9 7847.1 7867.6 7549.5 7713.1 7724.0 7730.2 7732.3 1892.1 2131.8 2179.4 2188.4 2221.5 2161.8 2177.9 2183.5 2198.8 2205.0 2119.6 2132.1 2172.9 2178.9 2179.4 1843.5 2078.6 2110.6 2134.4 2138.5 2101.7 2106.7 2125.1 2127.0 2128.4 7579.2 7593.9 7634.5 7644.1 7648.0 4460.5 4616.8 4618.5 4620.9 4639.9 3000.6 3026.4 3078.6 3117.8 3138.2 1006.0 1025.5 1029.5 1679.6 1701.5 10371.1 10461.2 10488.8 10492.9 10495.6 3941.4 4114.9 4214.3 4240.5 4242.8 8200.2 8251.1 8266.6 8272.2 8301.8 4549.6 4556.6 4557.2 4557.4 4589.0 3715.9 4231.7 4333.9 4342.3 4354.6 3438.7 3520.5 3554.1 3573.1 3584.6 1058.3 1080.1 1082.4 1088.7 1090.9 757.4 798.8 813.2 857.7 868.8 5241.7 5321.2 5425.1 5529.4 5612.7 420.3 420.4 421.1 429.3 431.2 3446.2 3475.2 3485.8 3526.5 3589.1 9327.6 9816.7 9917.0 9931.5 9941.6 9526.9 9543.8 9689.4 9707.3 9716.2 6845.5 7255.5 7417.0 7470.1 7482.2 5411.2 5423.0 5488.4 5507.2 5605.0 8676.1 8685.3 8808.9 8859.2 8901.2 8509.7 8767.7 8797.8 8885.6 8937.3 6080.5 6283.8 6296.7 6564.1 6678.9 6733.0 7258.0 7506.2 7533.1 7538.5 6498.5 6765.8 6782.6 6875.3 6942.2 6673.9 6683.9 6750.8 6826.3 6912.5 6388.0 6429.9 6442.1 6448.5 6466.4 4741.1 4776.2 4858.3 4873.8 4909.3 4740.9 4752.1 4791.2 4805.0 4902.9 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#4] prototype.html Cycles:180 Average:4431.24 Median:5080.38 stddev:1278.72 (25.2%) stddev-sans-first:1244.52 07:57:39 INFO - PROCESS | 10805 | Values: 319.9 321.5 323.9 326.3 331.2 5074.0 5131.2 5147.6 5153.8 5184.6 5049.6 5058.9 5077.2 5083.6 5098.7 3795.6 3872.7 3917.9 3985.3 4003.7 3969.7 3992.9 3999.1 4014.6 4016.0 3758.3 3960.4 3968.5 3984.8 3995.7 3821.2 3940.1 3941.6 3949.6 3967.7 3537.8 3539.3 3545.9 3547.6 3551.1 4800.2 4855.7 4870.8 4887.8 4894.6 4222.4 4452.5 4467.5 4493.9 4586.3 5239.7 5294.9 5295.0 5300.8 5300.9 3710.8 3714.9 3727.9 3728.3 3736.0 5307.8 5519.9 5582.3 5592.0 5624.6 3862.5 3871.5 3878.6 3881.3 3884.0 3926.7 3927.1 3945.2 3946.1 3947.7 4361.5 4502.0 4508.6 4508.7 4523.5 5267.2 5270.7 5304.6 5322.2 5338.8 1409.2 1427.2 1429.6 1429.7 1437.1 936.5 985.4 988.5 998.1 1017.7 4595.4 4599.7 4599.8 4605.7 4623.1 5397.5 5406.2 5420.2 5426.7 5435.2 4499.4 4579.9 4586.9 4603.5 4694.0 2922.2 2942.7 2957.4 2957.9 2962.1 5232.0 5238.9 5240.3 5248.9 5249.2 5492.7 5652.4 5657.8 5660.0 5727.0 5224.7 5229.3 5256.1 5259.8 5260.8 5453.4 5579.1 5579.4 5580.5 5587.6 5430.8 5434.8 5441.4 5442.8 5463.7 5198.0 5208.4 5258.8 5274.3 5278.0 3857.9 3915.7 3933.8 3942.0 3945.6 5417.0 5480.2 5516.4 5558.0 5560.1 5343.6 5352.5 5359.8 5360.8 5375.8 5173.8 5350.4 5353.9 5354.8 5372.1 5011.2 5271.1 5275.3 5288.8 5294.2 5202.0 5272.0 5281.5 5298.8 5300.9 5248.2 5283.6 5302.5 5303.0 5305.0 07:57:39 INFO - PROCESS | 10805 | 07:57:39 INFO - PROCESS | 10805 | [#5] yui.html Cycles:180 Average:12533.58 Median:3966.79 stddev:13925.92 (351.1%) stddev-sans-first:13936.55 07:57:39 INFO - PROCESS | 10805 | Values: 682.6 710.4 710.9 737.5 779.1 11149.3 11637.8 11866.1 11885.8 11907.1 12360.8 12420.1 12427.1 12440.4 12452.0 811.6 819.1 825.4 826.4 826.6 651.2 798.6 824.8 826.3 832.7 863.5 865.3 867.1 867.6 867.9 679.3 862.6 862.8 862.9 863.2 614.6 631.6 632.1 632.2 632.8 12828.2 12865.6 12870.3 12930.3 12944.9 11875.8 12175.7 12215.0 12497.1 12834.9 10055.5 10252.5 10267.8 10322.7 10351.4 3345.8 3350.5 3389.5 3414.6 3460.0 46910.5 47092.0 47110.8 47240.8 47451.3 9344.9 9352.4 9454.1 9479.6 10018.3 17119.1 17171.1 17193.8 17199.8 17219.0 6462.6 6703.3 6799.5 6843.7 6982.5 3791.3 3904.4 3934.8 3945.5 4044.9 2714.5 2765.0 2772.5 2774.3 2774.6 501.3 510.0 510.8 511.2 527.2 565.0 649.9 656.0 661.1 661.3 7846.9 8102.7 8114.4 8124.4 8462.9 503.6 517.5 637.6 650.5 675.8 3773.2 3988.1 4005.9 4022.2 4027.8 51755.0 52157.2 52165.7 52216.7 53544.5 39895.2 41364.0 42609.4 44548.8 45558.0 32195.4 32560.2 38739.2 38940.6 41609.8 7976.9 8076.3 8108.9 8182.4 8187.9 27581.0 27735.9 28208.9 28865.4 28983.0 35774.5 38455.4 38766.1 39264.0 39384.6 10571.3 10601.8 10676.3 10784.5 10962.4 11573.5 11745.9 11864.5 12010.6 12057.1 10274.3 10570.2 10846.0 10897.2 10994.2 11090.8 11291.6 11398.9 11738.5 11802.6 10645.2 10651.5 10950.9 11071.3 11460.2 9853.4 9961.3 10134.9 10196.6 10469.8 9365.7 9962.2 10074.5 10099.9 10142.1 07:57:39 INFO - PROCESS | 10805 | -------- Summary: end -------- 07:57:39 INFO - PROCESS | 10805 | 07:57:40 INFO - TEST-INFO | 10805: exit 0 07:57:40 INFO - TEST-OK | dromaeo_css | took 1118416ms 07:57:40 INFO - TEST-START | kraken 07:57:40 INFO - operating with platform_type : linux_ 07:57:40 INFO - Initialising browser for kraken test... 07:57:40 INFO - TEST-INFO | started process 10982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZ7QZ_/profile http://localhost:53373/getInfo.html) 07:57:44 INFO - PROCESS | 10982 | __metrics Screen width/height:1600/1200 07:57:44 INFO - PROCESS | 10982 | colorDepth:24 07:57:44 INFO - PROCESS | 10982 | Browser inner width/height: 1024/697 07:57:44 INFO - PROCESS | 10982 | __metrics 07:57:45 ERROR - PROCESS | 10982 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:57:46 INFO - TEST-INFO | 10982: exit 0 07:57:46 INFO - Browser initialized. 07:57:46 INFO - Running cycle 1/1 for kraken test... 07:57:46 INFO - TEST-INFO | started process 11063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZ7QZ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:58 INFO - PROCESS | 11063 | RSS: Main: 156258304 07:57:58 INFO - PROCESS | 11063 | 07:58:00 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53373/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:01 INFO - PROCESS | 11063 | RSS: Main: 210305024 07:58:01 INFO - PROCESS | 11063 | 07:58:04 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53373/tests/kraken/driver.html?testName=audio-dft) 07:58:05 INFO - PROCESS | 11063 | RSS: Main: 197464064 07:58:05 INFO - PROCESS | 11063 | 07:58:08 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53373/tests/kraken/driver.html?testName=audio-fft) 07:58:09 INFO - PROCESS | 11063 | RSS: Main: 266878976 07:58:09 INFO - PROCESS | 11063 | 07:58:11 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53373/tests/kraken/driver.html?testName=audio-oscillator) 07:58:11 INFO - PROCESS | 11063 | RSS: Main: 175284224 07:58:11 INFO - PROCESS | 11063 | 07:58:14 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:14 INFO - PROCESS | 11063 | RSS: Main: 179322880 07:58:14 INFO - PROCESS | 11063 | 07:58:17 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53373/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:18 INFO - PROCESS | 11063 | RSS: Main: 215576576 07:58:18 INFO - PROCESS | 11063 | 07:58:21 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53373/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:22 INFO - PROCESS | 11063 | RSS: Main: 216289280 07:58:22 INFO - PROCESS | 11063 | 07:58:25 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53373/tests/kraken/driver.html?testName=json-parse-financial) 07:58:26 INFO - PROCESS | 11063 | RSS: Main: 216322048 07:58:26 INFO - PROCESS | 11063 | 07:58:27 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:28 INFO - PROCESS | 11063 | RSS: Main: 201842688 07:58:28 INFO - PROCESS | 11063 | 07:58:30 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:30 INFO - PROCESS | 11063 | RSS: Main: 204115968 07:58:30 INFO - PROCESS | 11063 | 07:58:32 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:33 INFO - PROCESS | 11063 | RSS: Main: 216694784 07:58:33 INFO - PROCESS | 11063 | 07:58:36 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:37 INFO - PROCESS | 11063 | RSS: Main: 225796096 07:58:37 INFO - PROCESS | 11063 | 07:58:39 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:40 INFO - PROCESS | 11063 | RSS: Main: 221437952 07:58:40 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | Cycle 1(1): loaded http://localhost:53373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53373/tests/kraken/driver.html?testName=ai-astar) 07:58:42 INFO - PROCESS | 11063 | RSS: Main: 283844608 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | __start_tp_report 07:58:42 INFO - PROCESS | 11063 | _x_x_mozilla_page_load 07:58:42 INFO - PROCESS | 11063 | _x_x_mozilla_page_load_details 07:58:42 INFO - PROCESS | 11063 | |i|pagename|runs| 07:58:42 INFO - PROCESS | 11063 | |0;ai-astar;111;113;109;112;114;113;103;113;113;113 07:58:42 INFO - PROCESS | 11063 | |1;audio-beat-detection;160;131;162;183;131;158;159;138;195;137 07:58:42 INFO - PROCESS | 11063 | |2;audio-dft;161;161;162;158;161;163;161;162;160;161 07:58:42 INFO - PROCESS | 11063 | |3;audio-fft;73;77;98;105;73;73;76;117;107;73 07:58:42 INFO - PROCESS | 11063 | |4;audio-oscillator;95;96;148;94;95;95;151;95;95;146 07:58:42 INFO - PROCESS | 11063 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;116;117;117 07:58:42 INFO - PROCESS | 11063 | |6;imaging-darkroom;145;146;146;146;145;146;146;145;145;146 07:58:42 INFO - PROCESS | 11063 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:58:42 INFO - PROCESS | 11063 | |8;json-parse-financial;65;66;66;65;64;65;65;80;64;63 07:58:42 INFO - PROCESS | 11063 | |9;json-stringify-tinderbox;65;65;66;64;65;64;65;64;65;65 07:58:42 INFO - PROCESS | 11063 | |10;stanford-crypto-aes;80;79;80;78;80;79;80;80;79;79 07:58:42 INFO - PROCESS | 11063 | |11;stanford-crypto-ccm;132;134;141;134;131;145;136;138;171;133 07:58:42 INFO - PROCESS | 11063 | |12;stanford-crypto-pbkdf2;177;176;176;181;175;173;176;175;178;177 07:58:42 INFO - PROCESS | 11063 | |13;stanford-crypto-sha256-iterative;72;73;73;72;72;72;79;73;72;70 07:58:42 INFO - PROCESS | 11063 | __end_tp_report 07:58:42 INFO - PROCESS | 11063 | __start_cc_report 07:58:42 INFO - PROCESS | 11063 | _x_x_mozilla_cycle_collect,1893 07:58:42 INFO - PROCESS | 11063 | __end_cc_report 07:58:42 INFO - PROCESS | 11063 | __startTimestamp1461423522669__endTimestamp 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | ------- Summary: start ------- 07:58:42 INFO - PROCESS | 11063 | Number of tests: 14 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.27 (2.9%) stddev-sans-first:3.47 07:58:42 INFO - PROCESS | 11063 | Values: 111.0 113.0 109.0 112.0 114.0 113.0 103.0 113.0 113.0 113.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:159.50 stddev:21.72 (13.6%) stddev-sans-first:22.98 07:58:42 INFO - PROCESS | 11063 | Values: 160.0 131.0 162.0 183.0 131.0 158.0 159.0 138.0 195.0 137.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 07:58:42 INFO - PROCESS | 11063 | Values: 161.0 161.0 162.0 158.0 161.0 163.0 161.0 162.0 160.0 161.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.00 stddev:17.48 (23.9%) stddev-sans-first:17.77 07:58:42 INFO - PROCESS | 11063 | Values: 73.0 77.0 98.0 105.0 73.0 73.0 76.0 117.0 107.0 73.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.00 stddev:25.79 (27.2%) stddev-sans-first:26.70 07:58:42 INFO - PROCESS | 11063 | Values: 95.0 96.0 148.0 94.0 95.0 95.0 151.0 95.0 95.0 146.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:58:42 INFO - PROCESS | 11063 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:58:42 INFO - PROCESS | 11063 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:58:42 INFO - PROCESS | 11063 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.00 stddev:4.90 (7.5%) stddev-sans-first:5.17 07:58:42 INFO - PROCESS | 11063 | Values: 65.0 66.0 66.0 65.0 64.0 65.0 65.0 80.0 64.0 63.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 07:58:42 INFO - PROCESS | 11063 | Values: 65.0 65.0 66.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 07:58:42 INFO - PROCESS | 11063 | Values: 80.0 79.0 80.0 78.0 80.0 79.0 80.0 80.0 79.0 79.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:137.00 stddev:11.88 (8.7%) stddev-sans-first:12.29 07:58:42 INFO - PROCESS | 11063 | Values: 132.0 134.0 141.0 134.0 131.0 145.0 136.0 138.0 171.0 133.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:176.50 stddev:2.12 (1.2%) stddev-sans-first:2.24 07:58:42 INFO - PROCESS | 11063 | Values: 177.0 176.0 176.0 181.0 175.0 173.0 176.0 175.0 178.0 177.0 07:58:42 INFO - PROCESS | 11063 | 07:58:42 INFO - PROCESS | 11063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:2.35 (3.2%) stddev-sans-first:2.47 07:58:42 INFO - PROCESS | 11063 | Values: 72.0 73.0 73.0 72.0 72.0 72.0 79.0 73.0 72.0 70.0 07:58:42 INFO - PROCESS | 11063 | -------- Summary: end -------- 07:58:42 INFO - PROCESS | 11063 | 07:58:43 INFO - TEST-INFO | 11063: exit 0 07:58:43 INFO - TEST-OK | kraken | took 63296ms 07:58:43 INFO - SUITE-END | took 1181s 07:58:43 INFO - Completed test suite (00:19:41) 07:58:43 INFO - javascript benchmark 07:58:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.725663805301, 2665.0539058634195, 2677.986610066949, 2685.248130523452, 2705.864706764661, 4525.705829121113, 4583.243764778816, 4688.835890743825, 4695.037517308952, 4732.905341893164, 4618.838340658078, 4713.34013238147, 4719.315699223611, 4745.288206768986, 4746.881327966803, 4315.913681726363, 4319.784010799463, 4353.064091220387, 4383.320585309282, 4467.642588592905, 4383.057642606839, 4428.911421771562, 4473.865784026484, 4478.664100192498, 4487.46150461945, 4264.7227930184745, 4337.869863904057, 4338.674599405057, 4377.671674624416, 4389.0, 4236.597523235288, 4301.956980430187, 4365.279728844736, 4369.410129632491, 4385.693001489897, 4253.425787518676, 4255.0, 4255.446791917031, 4258.297380932174, 4297.914041719148, 4559.316102584606, 4571.405717256735, 4574.405327307462, 4579.702319349231, 4593.977030114861, 4936.284238785392, 5014.122528557525, 5108.438071812097, 5109.386873575195, 5109.4379618241965, 5052.747362631891, 5078.64449488536, 5080.79676812927, 5095.745212739348, 5099.311592934981, 4645.861763867806, 4729.172394830891, 4750.144973904661, 4755.025219829927, 4787.114383839001, 5142.2286657001005, 5159.74201289934, 5166.3025491558155, 5215.634905556574, 5225.16397376418, 4952.653314268039, 4957.7273249971595, 4959.082569724613, 4960.404751429852, 5010.949890501121, 4933.876653083702, 4979.228219625964, 5036.748162591855, 5038.294638750578, 5042.39491261051, 5023.497650234947, 5040.546350828443, 5046.1169295373165, 5074.441811400743, 5096.464871188472, 4991.301217829507, 4999.600031997432, 5007.899842003212, 5030.245463180479, 5051.419086804991, 4223.366495025709, 4292.377605247221, 4297.892552686208, 4359.934600980988, 4395.7142785718825, 3739.569949455793, 3761.887143385648, 3774.452704357853, 3779.7354185206773, 3781.962180378216, 4239.109786944715, 4278.593533614302, 4280.0, 4326.048269380732, 4391.473023237232, 4981.37732783402, 4981.501849814989, 4982.60139188864, 4983.878627308826, 5034.823781167642, 4321.092570560218, 4327.026419055687, 4329.242382583036, 4372.060007098489, 4372.737635741865, 4341.891452713644, 4532.0, 4548.613367863769, 4552.203364411214, 4593.173228818845, 4810.5670489656095, 4812.0, 4814.422269327633, 4835.057163853015, 4844.806207751792, 5034.974825125851, 5040.36995375578, 5042.84871453857, 5043.293938848491, 5102.897942041212, 4567.63458923292, 4778.952210477851, 4785.665003449725, 4850.902981940412, 4869.853904382874, 4995.875103122451, 5000.0, 5008.248762685626, 5011.674241174312, 5059.924101138412, 5076.82231121909, 5077.263796749525, 5083.415407228068, 5091.312672789126, 5092.821751238689, 4807.423109226916, 4831.95168048315, 4883.731394773322, 4930.186519224431, 4930.802767889388, 4902.803887844446, 4927.1377508935075, 4927.260910863256, 4932.524897363995, 4975.726335051607, 4691.437027556715, 4854.393200849894, 4866.756662166807, 4913.017396520639, 4917.188663870421, 4887.266909963534, 4896.559309662148, 4897.730624815669, 4902.289168070539, 4905.2151655734915, 4773.093112308789, 4799.112164249625, 4817.78319975609, 4877.780499877585, 4913.459519452786], "value": 4631.16282705616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.8878224355127, 600.4445887554012, 606.5875204860696, 613.6624856329018, 617.3486971245336, 26652.200433986985, 33837.323253534916, 34212.99999999997, 34304.65695343046, 34336.31327373451, 35913.820430897875, 36567.4514882277, 36592.817035914784, 36636.63363366365, 36675.083122921875, 7559.659815308324, 7737.342325902305, 7746.49647772893, 7754.8449031019345, 7756.573388463632, 7539.924600754004, 7667.5782831944225, 7667.808304792369, 7671.731489397872, 7835.138134805167, 7790.6883724651225, 7871.409644276673, 7875.0, 7878.0, 7878.842423151534, 7788.6105694715325, 7794.72718454857, 7835.804104897366, 7850.136484986619, 7857.921420785776, 7724.7682569523, 7836.647350869224, 7839.294463498256, 7848.607569621496, 7854.214578542157, 36995.630043699486, 37521.624783752086, 37542.62457375446, 37578.24843503142, 37590.43614345787, 3057.969420305813, 3058.510638297884, 3410.7100896423585, 3598.5142005829402, 3621.3481573316794, 27858.721412785817, 28296.0, 28323.57514637282, 28337.716622833716, 28486.572701409495, 3500.824958752052, 3578.6421357864006, 3613.385724426854, 3654.3604869148057, 3733.1227161617, 230329.0, 230906.0, 231703.0, 231707.0, 232215.0, 50582.0, 50971.49028509742, 51501.0, 51611.19360822353, 51667.483325166264, 55163.0, 55266.44733552694, 55363.72318138384, 55422.44577554253, 55448.0, 13917.095388799695, 14066.578002659937, 14082.225477598831, 14124.50564230247, 14150.85849141516, 10931.344119352865, 11004.39475828821, 11004.834927476095, 11006.724831879266, 11012.724681882857, 14963.625909352353, 16127.193640317937, 16371.672566548603, 16410.17949102564, 16428.0, 5024.723640199824, 6006.309274433496, 6044.969775151096, 6086.360932102066, 6340.397662222082, 922.3220932614523, 928.3223247029706, 962.2302158273353, 990.8464188050864, 1004.2016596805557, 26347.604785928226, 27741.445171096868, 28324.84267305988, 28813.855930720212, 28817.56773648397, 939.389396892012, 996.496769131584, 1021.4841505039907, 1042.3381152967768, 1097.2483848563759, 14400.927995359956, 14672.853271467362, 14944.402223910922, 15088.849111508744, 15261.160636165117, 350074.0, 353201.0, 355649.0, 357566.0, 358325.0, 47968.0, 48458.0, 48469.0, 48542.02915941732, 48555.271670924965, 1032.3805716569998, 1172.7068232941765, 1218.5674085699627, 1270.7966725323904, 1376.4769387632637, 24035.409888420676, 27219.0, 27352.452950941268, 28145.43709125847, 28312.150635480968, 38527.807360964136, 38608.80695596504, 38870.6112938867, 39045.21909561849, 39082.41376379413, 237339.0, 237535.0, 237579.0, 238204.0, 238310.0, 31598.36803263876, 32712.672873270963, 36659.63340366669, 37518.0, 37519.74881507118, 35602.287954241285, 36077.63922360848, 36212.27575448529, 36279.81860090682, 36910.446343304335, 30405.84797076089, 30968.0, 31034.68965310318, 31351.372972540878, 31806.6819331813, 31578.0, 33999.49000764941, 34105.65894341025, 34121.82939085289, 34253.828730856185, 34303.4854477178, 34511.30977380388, 34912.65087349094, 35021.64978350184, 35138.12154696153, 30255.09234722962, 30851.537226941164, 31021.224469388446, 31184.844075780384, 31220.0, 23863.164789232294, 24492.0, 24555.403898746525, 24637.50724985526, 24821.255362339158], "value": 16975.48202598349, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.36791350962835, 373.2907475795988, 394.9585293544178, 395.9425883246929, 398.74480332587166, 15671.60820979476, 17093.0, 17369.392071277507, 17509.0, 17576.472705818815, 16235.431759888406, 16946.661066778688, 17140.159514994917, 17365.044922529254, 17400.21699023544, 5117.744112794373, 5236.057509648262, 5270.92093618596, 5273.604479664022, 5289.523942845143, 3707.7589956652732, 3954.110325176841, 5768.394318596529, 6119.3880611938675, 6126.571140020201, 5880.353161152269, 5998.730057147439, 6047.3650266722025, 6075.513958883279, 6084.695765211722, 5783.5951483396175, 5885.264341957255, 5912.113183022538, 5921.0230311998685, 5924.08176732605, 3351.447011243142, 3562.5190599269026, 3565.8573657053685, 3566.3937130687846, 5053.4946505349535, 19584.70622940657, 19797.40607781769, 19916.900415497974, 20948.266810661553, 20993.0, 1865.822746839048, 1999.3901859932714, 2059.9588008239903, 2136.1241890824845, 2566.910158144456, 12867.806982895265, 13169.86830131696, 13237.470501179941, 13366.465341386333, 13652.317384130754, 1826.7351234071118, 1834.1287888253107, 1855.2857149997212, 1869.140195510067, 1910.646530391868, 58795.70602146962, 62342.0, 63374.04938925966, 63684.36315636831, 65436.0, 10044.397336159855, 10208.0, 10312.27814053009, 10327.84508232377, 10453.111485523816, 14211.147331159957, 14273.143611383142, 14305.0, 14340.856591434162, 14368.640783980483, 6380.042993550912, 6386.265579458329, 6551.377619126175, 6585.835354116185, 6644.036614690939, 5764.827055188267, 5783.681897495594, 5900.291964964232, 5954.8809023819285, 5960.552958528127, 4406.515283318897, 4448.866534003985, 4484.910301793946, 4565.0, 4566.725996440225, 1749.2827940544316, 1813.6463389638893, 1816.8909865408118, 1880.4117952196596, 1903.3338331584112, 404.7065877238978, 406.28899426004494, 890.9688160914337, 914.9451032938046, 975.9316847820585, 10372.844407333896, 10536.315139515908, 10610.893891061145, 10693.786124277627, 10819.0, 436.5832872329312, 437.49032377280747, 448.9842855500042, 451.09105153116496, 462.3226972485325, 5677.744501497443, 5901.380355062656, 5943.55423343251, 5953.613015154001, 5956.344802071769, 410801.0, 412969.7406051862, 418048.0, 424855.0, 427885.0, 82552.58723706462, 83250.0, 83319.5834020826, 83320.16679833124, 84482.0, 451.33202859767727, 454.82034596334927, 456.3474231848489, 458.2965148497041, 459.46701825882485, 9797.363171393836, 9854.55654495535, 10171.54228059754, 10224.846627300745, 10347.741306467398, 33414.665853341154, 33711.3257734839, 34243.65756342404, 34630.653693462744, 35652.28695426129, 46002.769986149855, 48222.758886205345, 51484.485155149465, 51804.0, 52029.0, 7548.509346892434, 7810.843783124419, 7825.726099586487, 7947.721829735931, 8110.0, 6678.49911256648, 8795.736127916172, 10610.575576977144, 11046.392448415092, 11373.715657108638, 7502.837060255669, 9077.273818094669, 9802.803943921224, 10370.274080814572, 10396.896031039592, 10390.0, 10468.267221294436, 10509.579616815548, 10614.0, 10639.787204255717, 5663.235463212413, 7800.531968081933, 10261.409481530374, 10635.840462392916, 10792.730181745519, 7647.158812530506, 7873.173316801883, 7887.723929662434, 7931.960340198493, 7976.401769867167, 7909.564973926489, 9588.0, 10072.798544029225, 10217.846732298873, 10591.099756520782], "value": 7527.1550654574385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.8417697787777, 1450.06470826317, 1477.674911519466, 1615.6526346835435, 1780.5281600375902, 6768.729250829961, 7634.465587408884, 7822.921770782291, 7847.058352997648, 7867.645955931983, 7549.509281896687, 7713.074431068279, 7724.0, 7730.226977302267, 7732.342750866169, 1892.0634286028435, 2131.765505794361, 2179.4333473296897, 2188.413400284797, 2221.5112675211426, 2161.7513985891587, 2177.912883484659, 2183.530540933699, 2198.835087368454, 2205.0297868937696, 2119.5654890747437, 2132.115172203534, 2172.9239476618322, 2178.8583742056794, 2179.3788770200495, 1843.4561804267705, 2078.615456140619, 2110.598986192626, 2134.445044288481, 2138.5081431270737, 2101.7057611934342, 2106.7050612914204, 2125.0649714125734, 2126.9787302126933, 2128.425325162213, 7579.242075792376, 7593.924060759432, 7634.4655874088285, 7644.082710074771, 7648.043994500687, 4460.50934397216, 4616.7691615419435, 4618.5381461853885, 4620.930686039712, 4639.86080417588, 3000.5949196858364, 3026.4098500792134, 3078.6459557150765, 3117.7973431726864, 3138.152698771342, 1005.9647912323034, 1025.5026312238558, 1029.510982283417, 1679.5717092141547, 1701.481048280274, 10371.118454931264, 10461.215408844291, 10488.790224195549, 10492.895071049268, 10495.580176792919, 3941.4087886816633, 4114.855980040684, 4214.262504061777, 4240.512341080754, 4242.809073591696, 8200.179982001871, 8251.051129120107, 8266.628001739937, 8272.214139656722, 8301.8339633207, 4549.5905368517, 4556.6126879215635, 4557.225271703818, 4557.361969324297, 4589.036302376471, 3715.888523344304, 4231.703780735381, 4333.891652708645, 4342.32693932441, 4354.629856462237, 3438.673326034023, 3520.4543295789194, 3554.111472131967, 3573.10672331917, 3584.6415358463946, 1058.343826827372, 1080.103514083309, 1082.426314053553, 1088.7387027113593, 1090.86909570852, 757.4243574883128, 798.8402319536116, 813.1624426840364, 857.7341024282492, 868.7871471489525, 5241.711705856214, 5321.201819727072, 5425.104857698515, 5529.391766905637, 5612.719364031782, 420.3106904676333, 420.3820384035463, 421.09464651000593, 429.2830972276306, 431.1592394830094, 3446.2418267981, 3475.165960169541, 3485.7734247273847, 3526.5415495985358, 3589.120665436985, 9327.626894924128, 9816.65641702537, 9916.950415247878, 9931.453770042717, 9941.602335906628, 9526.90473095274, 9543.809123817486, 9689.41863488193, 9707.271954603433, 9716.222702183808, 6845.520813543004, 7255.4921155518605, 7416.962915185498, 7470.103587569418, 7482.176960534337, 5411.242426060276, 5423.0, 5488.396276409671, 5507.173923911445, 5605.047141985954, 8676.132386761274, 8685.305175585812, 8808.911910881065, 8859.246964007874, 8901.154390332907, 8509.74470765878, 8767.693130740394, 8797.780055498664, 8885.555722213992, 8937.28501719848, 6080.513558915364, 6283.7800676976085, 6296.6851657417865, 6564.113844630913, 6678.899816502853, 6732.966335168293, 7258.0, 7506.211847755907, 7533.1336896257635, 7538.509996850187, 6498.545101842826, 6765.830854228487, 6782.593044417351, 6875.278095799869, 6942.236354000955, 6673.9332606673315, 6683.899741503784, 6750.763723269662, 6826.317368263134, 6912.516123871482, 6388.0, 6429.935700642934, 6442.098106265033, 6448.548601597843, 6466.41802237782, 4741.075490279362, 4776.21192503233, 4858.319835223142, 4873.780679869344, 4909.337239472626, 4740.857774266778, 4752.120857641347, 4791.161546729378, 4804.975975120102, 4902.9019419610695], "value": 4067.9452090778454, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8656564243018, 321.5241442664856, 323.8898774416698, 326.2707847959808, 331.19023986353346, 5074.0, 5131.153359695646, 5147.613928955329, 5153.81961631343, 5184.585233181346, 5049.596032317415, 5058.873528161797, 5077.162268225738, 5083.5933125349975, 5098.668586541872, 3795.601461846508, 3872.67082298005, 3917.8628747993826, 3985.302572049894, 4003.6997225208224, 3969.741966772165, 3992.8802135935825, 3999.0802115513447, 4014.635024091808, 4015.9799201003952, 3758.285925674113, 3960.425738267964, 3968.4840970673918, 3984.820683069269, 3995.680345572347, 3821.159344944108, 3940.1134744682217, 3941.625545573166, 3949.6050394960416, 3967.7222594418404, 3537.840797164108, 3539.292141571696, 3545.911352216215, 3547.5565554305713, 3551.076720052805, 4800.231962885957, 4855.68438051529, 4870.756462176877, 4887.75561221941, 4894.583960363373, 4222.374385861434, 4452.465704115494, 4467.530909254514, 4493.9101217975785, 4586.289125185602, 5239.73801309933, 5294.92057619136, 5295.040834891115, 5300.787968481256, 5300.946990530084, 3710.8144592770523, 3714.888553343404, 3727.925441491182, 3728.254349130185, 3735.9912823537493, 5307.832276899076, 5519.917201241985, 5582.33012038558, 5591.993441180586, 5624.606277560572, 3862.4592557042038, 3871.4967054283325, 3878.631530004645, 3881.340172170738, 3883.9611603884164, 3926.70549708773, 3927.1346110597237, 3945.191235796712, 3946.1121247719034, 3947.7236593438756, 4361.542038086019, 4501.977490112528, 4508.639308855284, 4508.729476231437, 4523.5250298718165, 5267.183586544092, 5270.708676374236, 5304.575633949275, 5322.175062865262, 5338.786448542015, 1409.2319685771279, 1427.1508452470764, 1429.5568373804153, 1429.7283516131902, 1437.0874494695734, 936.4989730494153, 985.4136788610765, 988.5403287471361, 998.1415982255255, 1017.7150397888603, 4595.379623750818, 4599.72401655895, 4599.816007359735, 4605.700629459075, 4623.075384922961, 5397.487238712316, 5406.243125962368, 5420.214068959979, 5426.674399535961, 5435.211894275308, 4499.370088187657, 4579.862604121881, 4586.908261834811, 4603.516630753789, 4694.0, 2922.1963959911195, 2942.7204415580914, 2957.4233024560435, 2957.8816847325866, 2962.1113665900143, 5231.973840130851, 5238.869028274324, 5240.349289973646, 5248.868778280574, 5249.186376111708, 5492.69790161537, 5652.434756524314, 5657.830265091971, 5660.037793575102, 5727.0, 5224.660397074178, 5229.267902493654, 5256.1327380982475, 5259.8422047338645, 5260.842174734764, 5453.372862120748, 5579.051561234681, 5579.442055794388, 5580.497755202051, 5587.55299576041, 5430.782768689208, 5434.75543600531, 5441.428649991693, 5442.782288708566, 5463.743339032125, 5198.0, 5208.4270730220405, 5258.842234732964, 5274.261603375454, 5277.973610131925, 3857.922841543097, 3915.7063220258024, 3933.783641899723, 3941.9605803941595, 3945.585713500041, 5416.9729151353995, 5480.232767412645, 5516.420775818642, 5558.0, 5560.138178582326, 5343.62594618373, 5352.518273355417, 5359.839204823861, 5360.812371566976, 5375.784968601369, 5173.81891633791, 5350.411454739898, 5353.892922141613, 5354.8487075279, 5372.113601255749, 5011.223260394645, 5271.1302635064785, 5275.287836142072, 5288.788448462018, 5294.152935530451, 5202.0, 5271.973640131775, 5281.524662780368, 5298.81454149103, 5300.893982120258, 5248.212768084818, 5283.603729720363, 5302.496262855023, 5303.0, 5305.0], "value": 4035.326948461574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.5768023825229, 710.3890654037529, 710.8507213485171, 737.4985010193068, 779.1429427629608, 11149.331040137597, 11637.825432618518, 11866.050715942725, 11885.762284754299, 11907.106966977468, 12360.752784944296, 12420.130590858644, 12427.13010089294, 12440.44018019189, 12452.0, 811.6347643560392, 819.074445876162, 825.3644693585935, 826.3554427546524, 826.6280173921759, 651.228294471051, 798.5967086621248, 824.826786374862, 826.277007618334, 832.7002279179491, 863.5466380150408, 865.2558799432514, 867.1458613265928, 867.600903584352, 867.9088695686956, 679.296927679849, 862.6118246788939, 862.7886167888845, 862.9439086459391, 863.2403484933282, 614.5912967876357, 631.5736877607596, 632.099258556555, 632.1781683811073, 632.7753647455133, 12828.230306181658, 12865.614031579067, 12870.29213393263, 12930.28883411412, 12944.87055129446, 11875.82186267198, 12175.695607609792, 12215.0, 12497.062720296015, 12834.871651283462, 10055.547500362502, 10252.538635761333, 10267.845982310271, 10322.690319290434, 10351.430671313075, 3345.7657963942534, 3350.5141754445467, 3389.457686770105, 3414.573178352706, 3460.0311912664492, 46910.5308946913, 47092.0, 47110.76444617789, 47240.76379618114, 47451.28823067691, 9344.859827102599, 9352.438853668802, 9454.14912657864, 9479.573419196153, 10018.298719089593, 17119.14404279806, 17171.055591942313, 17193.828061719472, 17199.828001720074, 17219.0, 6462.612243265419, 6703.296153903867, 6799.524033317621, 6843.726250949906, 6982.546134501241, 3791.298609757204, 3904.375299951994, 3934.783586902691, 3945.4870866787132, 4044.8988775280854, 2714.538528450168, 2765.0322387164333, 2772.5009498290096, 2774.292555398401, 2774.569941659046, 501.3382335317419, 510.0, 510.82631905152425, 511.2484647568069, 527.1697077103577, 564.9548036157098, 649.9122618446544, 655.9901601475982, 661.1438187547042, 661.262692098307, 7846.90606995832, 8102.716404925799, 8114.391420643476, 8124.350051995826, 8462.915370846336, 503.61725088931945, 517.5262246461918, 637.5728262064428, 650.4763665249425, 675.7769935921134, 3773.1699026214187, 3988.1026768977326, 4005.939910901339, 4022.1955608878343, 4027.838886444568, 51755.0, 52157.217641735406, 52165.7391713039, 52216.73891630518, 53544.464555353945, 39895.20209595792, 41364.0, 42609.360859587134, 44548.77725611416, 45558.0, 32195.35609287801, 32560.185995350304, 38739.225215495535, 38940.610593893696, 41609.79195104005, 7976.880346794919, 8076.313513351431, 8108.918910811052, 8182.427230094075, 8187.918120818716, 27581.0, 27735.861320693268, 28208.85895570591, 28865.42269154647, 28983.0, 35774.4633830498, 38455.423168653055, 38766.092543059945, 39264.0, 39384.6061539381, 10571.260011799408, 10601.787964240826, 10676.306040107369, 10784.474246957365, 10962.397068161008, 11573.537058517564, 11745.941270293593, 11864.466099025738, 12010.579629712918, 12057.095717821023, 10274.33216840903, 10570.207234457293, 10846.0, 10897.182711296526, 10994.175436842428, 11090.766674815553, 11291.604793832177, 11398.886011140114, 11738.530458781896, 11802.586909458129, 10645.201609879136, 10651.520681569504, 10950.890491094988, 11071.335719856834, 11460.197786155222, 9853.359531630422, 9961.302708810603, 10134.898651013396, 10196.592136314464, 10469.790604187721, 9365.672201472917, 9962.153216976349, 10074.496275186359, 10099.94950025245, 10142.137918277029], "value": 5948.267370464795, "unit": "score"}], "name": "dromaeo_css", "value": 6217.829112364269, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 109.0, 112.0, 114.0, 113.0, 103.0, 113.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 131.0, 162.0, 183.0, 131.0, 158.0, 159.0, 138.0, 195.0, 137.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 158.0, 161.0, 163.0, 161.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 98.0, 105.0, 73.0, 73.0, 76.0, 117.0, 107.0, 73.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 148.0, 94.0, 95.0, 95.0, 151.0, 95.0, 95.0, 146.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 64.0, 65.0, 65.0, 80.0, 64.0, 63.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 78.0, 80.0, 79.0, 80.0, 80.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 141.0, 134.0, 131.0, 145.0, 136.0, 138.0, 171.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 176.0, 181.0, 175.0, 173.0, 176.0, 175.0, 178.0, 177.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 72.0, 72.0, 72.0, 79.0, 73.0, 72.0, 70.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1582.5000000000002, "alertThreshold": 2.0}]} 07:58:43 INFO - Return code: 0 07:58:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:58:43 ERROR - # TBPL SUCCESS # 07:58:43 INFO - Running post-action listener: _resource_record_post_action 07:58:43 INFO - Running post-run listener: _resource_record_post_run 07:58:45 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283136000; Read time: 40; Write time: 194236 07:58:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 577536; Read time: 0; Write time: 40 07:58:45 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 281960448; Read time: 40; Write time: 194196 07:58:45 INFO - Running post-run listener: _upload_blobber_files 07:58:45 INFO - Blob upload gear active. 07:58:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:45 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 07:58:45 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'] 07:58:45 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 07:58:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:46 INFO - (blobuploader) - INFO - Done attempting. 07:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:46 INFO - (blobuploader) - INFO - Done attempting. 07:58:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:46 INFO - Return code: 0 07:58:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9950472f0747ad83e94627cde8d7d8a0346a1a84d9b1ea956a2432c0d6dfb79bec23a52300cb2799fcf15e0772a9c03ee998e61fdee89d58aacf7dd07e367460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d160bcdcfaad3f7fe87bef54da3cb2fe7c8678cfb22000ef6b14e183cc14b8167940aaad17cd8dd049ddb68d1527361778ad454f77d1a82c2fb34b51e8b61c81"} 07:58:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:46 INFO - Contents: 07:58:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9950472f0747ad83e94627cde8d7d8a0346a1a84d9b1ea956a2432c0d6dfb79bec23a52300cb2799fcf15e0772a9c03ee998e61fdee89d58aacf7dd07e367460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d160bcdcfaad3f7fe87bef54da3cb2fe7c8678cfb22000ef6b14e183cc14b8167940aaad17cd8dd049ddb68d1527361778ad454f77d1a82c2fb34b51e8b61c81"} 07:58:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:46 INFO - Copying logs to upload dir... 07:58:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.483128 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-23 07:58:46.923140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:46.927055) ========= 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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 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/9950472f0747ad83e94627cde8d7d8a0346a1a84d9b1ea956a2432c0d6dfb79bec23a52300cb2799fcf15e0772a9c03ee998e61fdee89d58aacf7dd07e367460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d160bcdcfaad3f7fe87bef54da3cb2fe7c8678cfb22000ef6b14e183cc14b8167940aaad17cd8dd049ddb68d1527361778ad454f77d1a82c2fb34b51e8b61c81"} build_url:https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/JAp-lvPISWG9OTxW3XphDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9950472f0747ad83e94627cde8d7d8a0346a1a84d9b1ea956a2432c0d6dfb79bec23a52300cb2799fcf15e0772a9c03ee998e61fdee89d58aacf7dd07e367460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d160bcdcfaad3f7fe87bef54da3cb2fe7c8678cfb22000ef6b14e183cc14b8167940aaad17cd8dd049ddb68d1527361778ad454f77d1a82c2fb34b51e8b61c81"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:46.951184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:46.951478) ========= 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=6dbc10da6d83fee962c624be000001a8-1461422211.276736-156579212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:58:47.034216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:58:47.034496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:58:47.034764) ========= ========= Total master_lag: 0.15 =========