builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1461586997.37 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.374640) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.375129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.375398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.391687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.392055) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 05:23:17-- 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% 43.2M=0s 2016-04-25 05:23:17 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.523689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.524007) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014103 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.572794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:17.573149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 05:23:17,863 truncating revision to first 12 chars 2016-04-25 05:23:17,863 Setting DEBUG logging. 2016-04-25 05:23:17,863 attempt 1/10 2016-04-25 05:23:17,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:23:18,115 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:18.116859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:18.117171) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:18.117545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:18.117803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:23:18.126836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 05:23:18.127232) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:18 INFO - MultiFileLogger online at 20160425 05:23:18 in /builds/slave/test 05:23:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:23:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:18 INFO - {'append_to_log': False, 05:23:18 INFO - 'base_work_dir': '/builds/slave/test', 05:23:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:23:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:18 INFO - 'branch': 'Fx-Team-Non-PGO', 05:23:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:18 INFO - 'config_files': ('talos/linux_config.py',), 05:23:18 INFO - 'default_actions': ('clobber', 05:23:18 INFO - 'read-buildbot-config', 05:23:18 INFO - 'download-and-extract', 05:23:18 INFO - 'populate-webroot', 05:23:18 INFO - 'create-virtualenv', 05:23:18 INFO - 'install', 05:23:18 INFO - 'run-tests'), 05:23:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:18 INFO - 'download_minidump_stackwalk': True, 05:23:18 INFO - 'download_symbols': 'ondemand', 05:23:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:18 INFO - 'installer_path': 'installer.exe', 05:23:18 INFO - 'log_level': 'info', 05:23:18 INFO - 'log_name': 'talos', 05:23:18 INFO - 'log_to_console': True, 05:23:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:18 INFO - 'opt_config_files': (), 05:23:18 INFO - 'pip_index': False, 05:23:18 INFO - 'sps_profile': False, 05:23:18 INFO - 'sps_profile_interval': 0, 05:23:18 INFO - 'suite': 'dromaeojs-e10s', 05:23:18 INFO - 'system_bits': '32', 05:23:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:18 INFO - 'title': 'talos-linux64-ix-057', 05:23:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:18 INFO - 'use_talos_json': True, 05:23:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:18 INFO - 'work_dir': 'build'} 05:23:18 INFO - ##### 05:23:18 INFO - ##### Running clobber step. 05:23:18 INFO - ##### 05:23:18 INFO - Running pre-action listener: _resource_record_pre_action 05:23:18 INFO - Running main action method: clobber 05:23:18 INFO - rmtree: /builds/slave/test/build 05:23:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:19 INFO - Running post-action listener: _resource_record_post_action 05:23:19 INFO - ##### 05:23:19 INFO - ##### Running read-buildbot-config step. 05:23:19 INFO - ##### 05:23:19 INFO - Running pre-action listener: _resource_record_pre_action 05:23:19 INFO - Running main action method: read_buildbot_config 05:23:19 INFO - Using buildbot properties: 05:23:19 INFO - { 05:23:19 INFO - "project": "", 05:23:19 INFO - "product": "firefox", 05:23:19 INFO - "script_repo_revision": "production", 05:23:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:23:19 INFO - "repository": "", 05:23:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:23:19 INFO - "buildid": "20160422035423", 05:23:19 INFO - "pgo_build": "False", 05:23:19 INFO - "basedir": "/builds/slave/test", 05:23:19 INFO - "buildnumber": 1200, 05:23:19 INFO - "slavename": "talos-linux64-ix-057", 05:23:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:23:19 INFO - "platform": "ubuntu64_hw", 05:23:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:23:19 INFO - "branch": "fx-team", 05:23:19 INFO - "repo_path": "integration/fx-team", 05:23:19 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:23:19 INFO - "stage_platform": "linux64", 05:23:19 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:23:19 INFO - "slavebuilddir": "test" 05:23:19 INFO - } 05:23:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:23:19 INFO - Running post-action listener: _resource_record_post_action 05:23:19 INFO - ##### 05:23:19 INFO - ##### Running download-and-extract step. 05:23:19 INFO - ##### 05:23:19 INFO - Running pre-action listener: _resource_record_pre_action 05:23:19 INFO - Running main action method: download_and_extract 05:23:19 INFO - mkdir: /builds/slave/test/build/tests 05:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:19 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:23:20 INFO - Downloaded 1361 bytes. 05:23:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:23:20 INFO - Using the following test package requirements: 05:23:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:23:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:23:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'jsshell-linux-x86_64.zip'], 05:23:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:23:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:23:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:23:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:23:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:23:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:20 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:23:21 INFO - Downloaded 22281373 bytes. 05:23:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:23:22 INFO - Return code: 0 05:23:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:22 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:23:23 INFO - Downloaded 22281373 bytes. 05:23:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:23:24 INFO - Return code: 0 05:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:24 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:23:25 INFO - Downloaded 10845952 bytes. 05:23:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:23:26 INFO - Return code: 0 05:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:26 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:23:27 INFO - Downloaded 54649298 bytes. 05:23:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:23:27 INFO - mkdir: /builds/slave/test/properties 05:23:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:27 INFO - Contents: 05:23:27 INFO - build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:23:28 INFO - Running post-action listener: _resource_record_post_action 05:23:28 INFO - Running post-action listener: set_extra_try_arguments 05:23:28 INFO - ##### 05:23:28 INFO - ##### Running populate-webroot step. 05:23:28 INFO - ##### 05:23:28 INFO - Running pre-action listener: _resource_record_pre_action 05:23:28 INFO - Running main action method: populate_webroot 05:23:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:28 INFO - '--tppagecycles', 05:23:28 INFO - '7'], 05:23:28 INFO - 'tests': ['tsvgm']}}, 05:23:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['damp', 'tps']}, 05:23:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'tests': ['damp', 'tps']}, 05:23:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['dromaeo_dom']}, 05:23:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['a11yr', 05:23:28 INFO - 'ts_paint', 05:23:28 INFO - 'tpaint', 05:23:28 INFO - 'sessionrestore', 05:23:28 INFO - 'sessionrestore_no_auto_restore', 05:23:28 INFO - 'tabpaint']}, 05:23:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['tsvgx', 05:23:28 INFO - 'tsvgr_opacity', 05:23:28 INFO - 'tart', 05:23:28 INFO - 'tscrollx', 05:23:28 INFO - 'cart']}, 05:23:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:28 INFO - 'tsvgr_opacity', 05:23:28 INFO - 'tart', 05:23:28 INFO - 'tscrollx', 05:23:28 INFO - 'cart']}, 05:23:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'talos_options': ['--disable-e10s'], 05:23:28 INFO - 'tests': ['tp5o']}, 05:23:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'tests': ['tp5o']}, 05:23:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'talos_options': ['--disable-e10s', 05:23:28 INFO - '--xperf_path', 05:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:28 INFO - 'tests': ['tp5n']}, 05:23:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:28 INFO - 'talos_options': ['--xperf_path', 05:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:28 INFO - 'tests': ['tp5n']}}, 05:23:28 INFO - 'talos.zip': {'path': '', 05:23:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:28 INFO - Running post-action listener: _resource_record_post_action 05:23:28 INFO - ##### 05:23:28 INFO - ##### Running create-virtualenv step. 05:23:28 INFO - ##### 05:23:28 INFO - Running pre-action listener: _resource_record_pre_action 05:23:28 INFO - Running main action method: create_virtualenv 05:23:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:23:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:28 INFO - Using real prefix '/usr' 05:23:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:30 INFO - Installing pip.................done. 05:23:30 INFO - Return code: 0 05:23:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:30 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:23:30 INFO - Using env: {'DISPLAY': ':0', 05:23:30 INFO - 'HOME': '/home/cltbld', 05:23:30 INFO - 'LANG': 'en_US.UTF-8', 05:23:30 INFO - 'LANGUAGE': 'en_US:en', 05:23:30 INFO - 'LOGNAME': 'cltbld', 05:23:30 INFO - 'MAIL': '/var/mail/cltbld', 05:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:30 INFO - 'MOZ_NO_REMOTE': '1', 05:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:30 INFO - 'NO_EM_RESTART': '1', 05:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:30 INFO - 'PWD': '/builds/slave/test', 05:23:30 INFO - 'SHELL': '/bin/bash', 05:23:30 INFO - 'SHLVL': '1', 05:23:30 INFO - 'TERM': 'linux', 05:23:30 INFO - 'TMOUT': '86400', 05:23:30 INFO - 'USER': 'cltbld', 05:23:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:30 INFO - '_': '/tools/buildbot/bin/python'} 05:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:23:31 INFO - Cleaning up... 05:23:31 INFO - Return code: 0 05:23:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:31 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:23:31 INFO - Using env: {'DISPLAY': ':0', 05:23:31 INFO - 'HOME': '/home/cltbld', 05:23:31 INFO - 'LANG': 'en_US.UTF-8', 05:23:31 INFO - 'LANGUAGE': 'en_US:en', 05:23:31 INFO - 'LOGNAME': 'cltbld', 05:23:31 INFO - 'MAIL': '/var/mail/cltbld', 05:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:31 INFO - 'MOZ_NO_REMOTE': '1', 05:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:31 INFO - 'NO_EM_RESTART': '1', 05:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:31 INFO - 'PWD': '/builds/slave/test', 05:23:31 INFO - 'SHELL': '/bin/bash', 05:23:31 INFO - 'SHLVL': '1', 05:23:31 INFO - 'TERM': 'linux', 05:23:31 INFO - 'TMOUT': '86400', 05:23:31 INFO - 'USER': 'cltbld', 05:23:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:31 INFO - '_': '/tools/buildbot/bin/python'} 05:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:31 INFO - Downloading/unpacking psutil>=0.7.1 05:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:33 INFO - Installing collected packages: psutil 05:23:33 INFO - Running setup.py install for psutil 05:23:33 INFO - building 'psutil._psutil_linux' extension 05:23:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:23:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:23:33 INFO - building 'psutil._psutil_posix' extension 05:23:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:23:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:23:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:33 INFO - Successfully installed psutil 05:23:33 INFO - Cleaning up... 05:23:33 INFO - Return code: 0 05:23:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:33 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:23:33 INFO - Using env: {'DISPLAY': ':0', 05:23:33 INFO - 'HOME': '/home/cltbld', 05:23:33 INFO - 'LANG': 'en_US.UTF-8', 05:23:33 INFO - 'LANGUAGE': 'en_US:en', 05:23:33 INFO - 'LOGNAME': 'cltbld', 05:23:33 INFO - 'MAIL': '/var/mail/cltbld', 05:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:33 INFO - 'MOZ_NO_REMOTE': '1', 05:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:33 INFO - 'NO_EM_RESTART': '1', 05:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:33 INFO - 'PWD': '/builds/slave/test', 05:23:33 INFO - 'SHELL': '/bin/bash', 05:23:33 INFO - 'SHLVL': '1', 05:23:33 INFO - 'TERM': 'linux', 05:23:33 INFO - 'TMOUT': '86400', 05:23:33 INFO - 'USER': 'cltbld', 05:23:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:33 INFO - '_': '/tools/buildbot/bin/python'} 05:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:23:36 INFO - Installing collected packages: mozsystemmonitor 05:23:36 INFO - Running setup.py install for mozsystemmonitor 05:23:36 INFO - Successfully installed mozsystemmonitor 05:23:36 INFO - Cleaning up... 05:23:36 INFO - Return code: 0 05:23:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:36 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:23:36 INFO - Using env: {'DISPLAY': ':0', 05:23:36 INFO - 'HOME': '/home/cltbld', 05:23:36 INFO - 'LANG': 'en_US.UTF-8', 05:23:36 INFO - 'LANGUAGE': 'en_US:en', 05:23:36 INFO - 'LOGNAME': 'cltbld', 05:23:36 INFO - 'MAIL': '/var/mail/cltbld', 05:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:36 INFO - 'MOZ_NO_REMOTE': '1', 05:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:36 INFO - 'NO_EM_RESTART': '1', 05:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:36 INFO - 'PWD': '/builds/slave/test', 05:23:36 INFO - 'SHELL': '/bin/bash', 05:23:36 INFO - 'SHLVL': '1', 05:23:36 INFO - 'TERM': 'linux', 05:23:36 INFO - 'TMOUT': '86400', 05:23:36 INFO - 'USER': 'cltbld', 05:23:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:36 INFO - '_': '/tools/buildbot/bin/python'} 05:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:38 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:39 INFO - Downloading docopt-0.6.1.tar.gz 05:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:39 INFO - Running setup.py install for blobuploader 05:23:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:39 INFO - Running setup.py install for requests 05:23:39 INFO - Running setup.py install for docopt 05:23:39 INFO - Successfully installed blobuploader requests docopt 05:23:39 INFO - Cleaning up... 05:23:39 INFO - Return code: 0 05:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:39 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:39 INFO - Using env: {'DISPLAY': ':0', 05:23:39 INFO - 'HOME': '/home/cltbld', 05:23:39 INFO - 'LANG': 'en_US.UTF-8', 05:23:39 INFO - 'LANGUAGE': 'en_US:en', 05:23:39 INFO - 'LOGNAME': 'cltbld', 05:23:39 INFO - 'MAIL': '/var/mail/cltbld', 05:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:39 INFO - 'MOZ_NO_REMOTE': '1', 05:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:39 INFO - 'NO_EM_RESTART': '1', 05:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:39 INFO - 'PWD': '/builds/slave/test', 05:23:39 INFO - 'SHELL': '/bin/bash', 05:23:39 INFO - 'SHLVL': '1', 05:23:39 INFO - 'TERM': 'linux', 05:23:39 INFO - 'TMOUT': '86400', 05:23:39 INFO - 'USER': 'cltbld', 05:23:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:39 INFO - '_': '/tools/buildbot/bin/python'} 05:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:40 INFO - Running setup.py (path:/tmp/pip-uGxbO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:40 INFO - Running setup.py (path:/tmp/pip-fUphNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:40 INFO - Running setup.py (path:/tmp/pip-jHAqKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:40 INFO - Running setup.py (path:/tmp/pip-Db035w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:40 INFO - Running setup.py (path:/tmp/pip-OkOUyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:40 INFO - Running setup.py (path:/tmp/pip-aGnvCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:40 INFO - Running setup.py (path:/tmp/pip-k8QoEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:40 INFO - Running setup.py (path:/tmp/pip-RSJ9Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:40 INFO - Running setup.py (path:/tmp/pip-4927_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:40 INFO - Running setup.py (path:/tmp/pip-g58xz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:40 INFO - Running setup.py (path:/tmp/pip-a1QpbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:40 INFO - Running setup.py (path:/tmp/pip-n2fyEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:40 INFO - Running setup.py (path:/tmp/pip-ErVM2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:41 INFO - Running setup.py (path:/tmp/pip-Gv8iy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:41 INFO - Running setup.py (path:/tmp/pip-RRkKAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:41 INFO - Running setup.py (path:/tmp/pip-er1Ure-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:41 INFO - Running setup.py (path:/tmp/pip-xVTy97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:41 INFO - Running setup.py install for manifestparser 05:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:41 INFO - Running setup.py install for mozcrash 05:23:41 INFO - Running setup.py install for mozdebug 05:23:41 INFO - Running setup.py install for mozdevice 05:23:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:41 INFO - Running setup.py install for mozfile 05:23:41 INFO - Running setup.py install for mozhttpd 05:23:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:41 INFO - Running setup.py install for mozinfo 05:23:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for mozInstall 05:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for mozleak 05:23:42 INFO - Running setup.py install for mozlog 05:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for moznetwork 05:23:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for mozprocess 05:23:42 INFO - Running setup.py install for mozprofile 05:23:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for mozrunner 05:23:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:42 INFO - Running setup.py install for mozscreenshot 05:23:42 INFO - Running setup.py install for moztest 05:23:42 INFO - Running setup.py install for mozversion 05:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:43 INFO - Cleaning up... 05:23:43 INFO - Return code: 0 05:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:43 INFO - Using env: {'DISPLAY': ':0', 05:23:43 INFO - 'HOME': '/home/cltbld', 05:23:43 INFO - 'LANG': 'en_US.UTF-8', 05:23:43 INFO - 'LANGUAGE': 'en_US:en', 05:23:43 INFO - 'LOGNAME': 'cltbld', 05:23:43 INFO - 'MAIL': '/var/mail/cltbld', 05:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:43 INFO - 'MOZ_NO_REMOTE': '1', 05:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:43 INFO - 'NO_EM_RESTART': '1', 05:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:43 INFO - 'PWD': '/builds/slave/test', 05:23:43 INFO - 'SHELL': '/bin/bash', 05:23:43 INFO - 'SHLVL': '1', 05:23:43 INFO - 'TERM': 'linux', 05:23:43 INFO - 'TMOUT': '86400', 05:23:43 INFO - 'USER': 'cltbld', 05:23:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:43 INFO - '_': '/tools/buildbot/bin/python'} 05:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:43 INFO - Running setup.py (path:/tmp/pip-jO0gCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:43 INFO - Running setup.py (path:/tmp/pip-hxVQWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:43 INFO - Running setup.py (path:/tmp/pip-7wOfWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:43 INFO - Running setup.py (path:/tmp/pip-CJU69p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:43 INFO - Running setup.py (path:/tmp/pip-Uf9G9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:43 INFO - Running setup.py (path:/tmp/pip-ghWm3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:43 INFO - Running setup.py (path:/tmp/pip-lvzeAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:43 INFO - Running setup.py (path:/tmp/pip-y74gq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:43 INFO - Running setup.py (path:/tmp/pip-5sAk2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:43 INFO - Running setup.py (path:/tmp/pip-DAael7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:44 INFO - Running setup.py (path:/tmp/pip-Bl2xTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:44 INFO - Running setup.py (path:/tmp/pip-ID6KPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:44 INFO - Running setup.py (path:/tmp/pip-4FMmHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:44 INFO - Running setup.py (path:/tmp/pip-F3YIBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:44 INFO - Running setup.py (path:/tmp/pip-k7sBEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:44 INFO - Running setup.py (path:/tmp/pip-jCaqVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:44 INFO - Running setup.py (path:/tmp/pip-w9u8xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:46 INFO - Downloading blessings-1.6.tar.gz 05:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:46 INFO - Installing collected packages: blessings 05:23:46 INFO - Running setup.py install for blessings 05:23:46 INFO - Successfully installed blessings 05:23:46 INFO - Cleaning up... 05:23:46 INFO - Return code: 0 05:23:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:46 INFO - Reading from file tmpfile_stdout 05:23:46 INFO - Current package versions: 05:23:46 INFO - argparse == 1.2.1 05:23:46 INFO - blessings == 1.6 05:23:46 INFO - blobuploader == 1.2.4 05:23:46 INFO - docopt == 0.6.1 05:23:46 INFO - manifestparser == 1.1 05:23:46 INFO - mozInstall == 1.12 05:23:46 INFO - mozcrash == 0.17 05:23:46 INFO - mozdebug == 0.1 05:23:46 INFO - mozdevice == 0.48 05:23:46 INFO - mozfile == 1.2 05:23:46 INFO - mozhttpd == 0.7 05:23:46 INFO - mozinfo == 0.9 05:23:46 INFO - mozleak == 0.1 05:23:46 INFO - mozlog == 3.1 05:23:46 INFO - moznetwork == 0.27 05:23:46 INFO - mozprocess == 0.22 05:23:46 INFO - mozprofile == 0.28 05:23:46 INFO - mozrunner == 6.11 05:23:46 INFO - mozscreenshot == 0.1 05:23:46 INFO - mozsystemmonitor == 0.0 05:23:46 INFO - moztest == 0.7 05:23:46 INFO - mozversion == 1.4 05:23:46 INFO - psutil == 3.1.1 05:23:46 INFO - requests == 1.2.3 05:23:46 INFO - wsgiref == 0.1.2 05:23:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:46 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 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:46 INFO - Using env: {'DISPLAY': ':0', 05:23:46 INFO - 'HOME': '/home/cltbld', 05:23:46 INFO - 'LANG': 'en_US.UTF-8', 05:23:46 INFO - 'LANGUAGE': 'en_US:en', 05:23:46 INFO - 'LOGNAME': 'cltbld', 05:23:46 INFO - 'MAIL': '/var/mail/cltbld', 05:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:46 INFO - 'MOZ_NO_REMOTE': '1', 05:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:46 INFO - 'NO_EM_RESTART': '1', 05:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:46 INFO - 'PWD': '/builds/slave/test', 05:23:46 INFO - 'SHELL': '/bin/bash', 05:23:46 INFO - 'SHLVL': '1', 05:23:46 INFO - 'TERM': 'linux', 05:23:46 INFO - 'TMOUT': '86400', 05:23:46 INFO - 'USER': 'cltbld', 05:23:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:46 INFO - '_': '/tools/buildbot/bin/python'} 05:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:23:47 INFO - Cleaning up... 05:23:47 INFO - Return code: 0 05:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:23:47 INFO - Using env: {'DISPLAY': ':0', 05:23:47 INFO - 'HOME': '/home/cltbld', 05:23:47 INFO - 'LANG': 'en_US.UTF-8', 05:23:47 INFO - 'LANGUAGE': 'en_US:en', 05:23:47 INFO - 'LOGNAME': 'cltbld', 05:23:47 INFO - 'MAIL': '/var/mail/cltbld', 05:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:47 INFO - 'MOZ_NO_REMOTE': '1', 05:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:47 INFO - 'NO_EM_RESTART': '1', 05:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:47 INFO - 'PWD': '/builds/slave/test', 05:23:47 INFO - 'SHELL': '/bin/bash', 05:23:47 INFO - 'SHLVL': '1', 05:23:47 INFO - 'TERM': 'linux', 05:23:47 INFO - 'TMOUT': '86400', 05:23:47 INFO - 'USER': 'cltbld', 05:23:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:47 INFO - '_': '/tools/buildbot/bin/python'} 05:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:47 INFO - Downloading/unpacking jsonschema 05:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:49 INFO - Downloading/unpacking functools32 (from jsonschema) 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:49 INFO - warning: no files found matching '*.txt' 05:23:49 INFO - no previously-included directories found matching 'build' 05:23:49 INFO - no previously-included directories found matching 'dist' 05:23:49 INFO - no previously-included directories found matching '.git*' 05:23:49 INFO - Installing collected packages: jsonschema, functools32 05:23:49 INFO - Running setup.py install for functools32 05:23:49 INFO - warning: no files found matching '*.txt' 05:23:49 INFO - no previously-included directories found matching 'build' 05:23:49 INFO - no previously-included directories found matching 'dist' 05:23:49 INFO - no previously-included directories found matching '.git*' 05:23:49 INFO - Successfully installed jsonschema functools32 05:23:49 INFO - Cleaning up... 05:23:49 INFO - Return code: 0 05:23:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ab4daaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:23:49 INFO - Using env: {'DISPLAY': ':0', 05:23:49 INFO - 'HOME': '/home/cltbld', 05:23:49 INFO - 'LANG': 'en_US.UTF-8', 05:23:49 INFO - 'LANGUAGE': 'en_US:en', 05:23:49 INFO - 'LOGNAME': 'cltbld', 05:23:49 INFO - 'MAIL': '/var/mail/cltbld', 05:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:49 INFO - 'MOZ_NO_REMOTE': '1', 05:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:49 INFO - 'NO_EM_RESTART': '1', 05:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:49 INFO - 'PWD': '/builds/slave/test', 05:23:49 INFO - 'SHELL': '/bin/bash', 05:23:49 INFO - 'SHLVL': '1', 05:23:49 INFO - 'TERM': 'linux', 05:23:49 INFO - 'TMOUT': '86400', 05:23:49 INFO - 'USER': 'cltbld', 05:23:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:49 INFO - '_': '/tools/buildbot/bin/python'} 05:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:49 INFO - Downloading/unpacking flake8 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:23:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:23:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:23:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:52 INFO - no previously-included directories found matching 'docs/_build' 05:23:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:23:52 INFO - Running setup.py install for pep8 05:23:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:52 INFO - no previously-included directories found matching 'docs/_build' 05:23:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:23:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:23:52 INFO - Cleaning up... 05:23:52 INFO - Return code: 0 05:23:52 INFO - Running post-action listener: _resource_record_post_action 05:23:52 INFO - Running post-action listener: _start_resource_monitoring 05:23:52 INFO - Starting resource monitoring. 05:23:52 INFO - ##### 05:23:52 INFO - ##### Running install step. 05:23:52 INFO - ##### 05:23:52 INFO - Running pre-action listener: _resource_record_pre_action 05:23:52 INFO - Running main action method: install 05:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:52 INFO - Reading from file tmpfile_stdout 05:23:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:52 INFO - Reading from file tmpfile_stdout 05:23:52 INFO - Output received: 05:23:52 INFO - Usage: mozinstall [options] installer 05:23:52 INFO - Options: 05:23:52 INFO - -h, --help show this help message and exit 05:23:52 INFO - -d DEST, --destination=DEST 05:23:52 INFO - Directory to install application into. [default: 05:23:52 INFO - "/builds/slave/test"] 05:23:52 INFO - --app=APP Application being installed. [default: firefox] 05:23:52 INFO - mkdir: /builds/slave/test/build/application 05:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:24:08 INFO - Reading from file tmpfile_stdout 05:24:08 INFO - Output received: 05:24:08 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:08 INFO - Running post-action listener: _resource_record_post_action 05:24:08 INFO - ##### 05:24:08 INFO - ##### Running run-tests step. 05:24:08 INFO - ##### 05:24:08 INFO - Running pre-action listener: _resource_record_pre_action 05:24:08 INFO - Running main action method: run_tests 05:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:08 INFO - Python 2.7.3 05:24:08 INFO - Return code: 0 05:24:08 INFO - grabbing minidump binary from tooltool 05:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:08 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 0x152f410>, '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 0x1530310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15307a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:24:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:24:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:08 INFO - Return code: 0 05:24:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:24:09 INFO - Return code: 0 05:24:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:24:09 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:24:09 INFO - Using env: {'DISPLAY': ':0', 05:24:09 INFO - 'HOME': '/home/cltbld', 05:24:09 INFO - 'LANG': 'en_US.UTF-8', 05:24:09 INFO - 'LANGUAGE': 'en_US:en', 05:24:09 INFO - 'LOGNAME': 'cltbld', 05:24:09 INFO - 'MAIL': '/var/mail/cltbld', 05:24:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:09 INFO - 'MOZ_NO_REMOTE': '1', 05:24:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:09 INFO - 'NO_EM_RESTART': '1', 05:24:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:09 INFO - 'PWD': '/builds/slave/test', 05:24:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:09 INFO - 'SHELL': '/bin/bash', 05:24:09 INFO - 'SHLVL': '1', 05:24:09 INFO - 'TERM': 'linux', 05:24:09 INFO - 'TMOUT': '86400', 05:24:09 INFO - 'USER': 'cltbld', 05:24:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164', 05:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:09 INFO - '_': '/tools/buildbot/bin/python'} 05:24:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:24:09 INFO - mozversion application_buildid: 20160422035423 05:24:09 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:24:09 INFO - mozversion application_display_name: Nightly 05:24:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:09 INFO - mozversion application_name: Firefox 05:24:09 INFO - mozversion application_remotingname: firefox 05:24:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:24:09 INFO - mozversion application_vendor: Mozilla 05:24:09 INFO - mozversion application_version: 48.0a1 05:24:09 INFO - mozversion platform_buildid: 20160422035423 05:24:09 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:24:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:09 INFO - mozversion platform_version: 48.0a1 05:24:09 INFO - using testdate: 1461587049 05:24:09 INFO - actual date: 1461587049 05:24:09 INFO - starting webserver on 'localhost:57746' 05:24:09 INFO - SUITE-START | Running 2 tests 05:24:09 INFO - TEST-START | dromaeo_css 05:24:09 INFO - operating with platform_type : linux_ 05:24:09 INFO - Initialising browser for dromaeo_css test... 05:24:09 INFO - TEST-INFO | started process 24619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfUFHp9/profile http://localhost:57746/getInfo.html) 05:24:14 INFO - PROCESS | 24619 | 05:24:14 INFO - PROCESS | 24619 | (process:24686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:15 INFO - PROCESS | 24619 | __metrics Screen width/height:1600/1200 05:24:15 INFO - PROCESS | 24619 | colorDepth:24 05:24:15 INFO - PROCESS | 24619 | Browser inner width/height: 1024/697 05:24:15 INFO - PROCESS | 24619 | __metrics 05:24:15 ERROR - PROCESS | 24619 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:24:16 INFO - TEST-INFO | 24619: exit 0 05:24:16 INFO - Browser initialized. 05:24:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:16 INFO - TEST-INFO | started process 24737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfUFHp9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:18 INFO - PROCESS | 24737 | 05:24:18 INFO - PROCESS | 24737 | (process:24796): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:28 INFO - PROCESS | 24737 | RSS: Main: 164962304 05:24:28 INFO - PROCESS | 24737 | 05:25:18 INFO - PROCESS | 24737 | 1461587118353 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:27:30 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57746/tests/dromaeo/cssquery-ext.html) 05:27:30 INFO - PROCESS | 24737 | RSS: Main: 168316928 05:27:30 INFO - PROCESS | 24737 | 05:30:32 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-ext.html (next: http://localhost:57746/tests/dromaeo/cssquery-jquery.html) 05:30:33 INFO - PROCESS | 24737 | RSS: Main: 165580800 05:30:33 INFO - PROCESS | 24737 | 05:33:35 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57746/tests/dromaeo/cssquery-mootools.html) 05:33:36 INFO - PROCESS | 24737 | RSS: Main: 166989824 05:33:36 INFO - PROCESS | 24737 | 05:36:37 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57746/tests/dromaeo/cssquery-prototype.html) 05:36:38 INFO - PROCESS | 24737 | RSS: Main: 164769792 05:36:38 INFO - PROCESS | 24737 | 05:39:41 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57746/tests/dromaeo/cssquery-yui.html) 05:39:41 INFO - PROCESS | 24737 | RSS: Main: 165810176 05:39:41 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | Cycle 1(1): loaded http://localhost:57746/tests/dromaeo/cssquery-yui.html (next: http://localhost:57746/tests/dromaeo/cssquery-dojo.html) 05:42:44 INFO - PROCESS | 24737 | RSS: Main: 168009728 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | __start_tp_report 05:42:44 INFO - PROCESS | 24737 | _x_x_mozilla_page_load 05:42:44 INFO - PROCESS | 24737 | _x_x_mozilla_page_load_details 05:42:44 INFO - PROCESS | 24737 | |i|pagename|runs| 05:42:44 INFO - PROCESS | 24737 | |0;dojo.html;2628.4611654610803;2687.2207059952607;2695.380062585604;2719.2114286856813;2727.6590426196726;4686.648501362403;4713.245880659095;4728.66899317048;4772.260299653555;4782.234842425212;4687.554682305184;4743.76281185941;4838.153323168449;4890.951090489094;4904;4430.1139772045635;4465.642748580122;4499.235130027903;4509.323601459791;4553.4991150973365;4458.4872739634875;4487.910241795178;4501.324801279818;4529.547045295477;4532.116237333721;4337.110892267109;4381.693281470299;4401.449818772653;4446.977765111186;4451.688381813275;4324.740515569076;4347.282698354799;4359.302511598161;4360.433143691332;4411;4372.497162826284;4384.364267181273;4393.187260356813;4393.824247030115;4432.71187372823;4648.651351148644;4685.1332503486965;4717.952820471785;4737.597304229144;4750.904981900378;5011.874703132415;5024.145895197825;5079.5428411443145;5102.6428150029515;5107.438181799999;5112.105381558213;5133.897322053575;5139.820106296262;5145.151050076733;5224.242484839715;4876.097921884428;4886.120498310267;4897.824522114667;4899.191633380524;4948.282499037656;5318.946810531846;5375.623706340597;5382.91925621116;5389.326334208224;5447.4824891635235;4981.302617633534;5051.217061355495;5123.2827404163445;5148.124818780741;5151.6908985461;5187.818426355059;5188.792448302102;5198.662086964335;5203.765830537559;5239.895202095937;4979.751012449363;5078.263651770547;5147.871303217449;5173.1722924331925;5180.352455943007;5024.874378140503;5080.974595127074;5086.567641750418;5087.97456012725;5099.3370861787735;4315.1585440838735;4315.287977483743;4328.177646247203;4353.085851971058;4361.018770776614;3753.155540003477;3757.1546402059867;3779.848806047727;3801.429785532137;3826.598207188261;4280.379344994958;4377.16833801583;4386.298192289219;4423.712458690175;4456.888577785517;5125.897482050338;5150.40770311419;5150.690958542499;5151;5198.376194856642;4401.625861801783;4405.691601587858;4410.757408342572;4462.888427789331;4469.150861336336;4556.7721613919175;4600.332951721982;4631.0506346198945;4719.457262414798;4720.787564559603;4844.370231869905;4872.805087796449;4888.951110488921;4906.313116163811;4977.0792403405485;5220.1647736362;5258.921116183184;5266.289050978069;5281.9471805281455;5293.947060529345;4749.3113498541825;4817.205161148511;4855.223164293696;4889.804407823647;4900.926486102782;5041.924371134509;5074.289599456005;5076.314697515788;5076.898462030665;5123.359580052494;5051.646384753032;5151.8196863109615;5154.639175257846;5157.381114266312;5179;4849.878753031202;4983.401991760867;5000;5033.874153146201;5049.772760225872;4947.752612369295;4952.7771250294545;5006.774695138654;5014.799408023784;5026.371703537058;4876;4890;4922.680025798311;4931;4980.676256043345;5016.247562865454;5042.319286896369;5042.873928151826;5066.31604733371;5100.770465329143;4894.583960363267;4924.82763103304;4933.4819843915875;4939.728314942713;4951.8266860659705 05:42:44 INFO - PROCESS | 24737 | |1;ext.html;578.8929048126097;597.3041406761123;601.0983524712931;621.987560248795;628.3025841316141;28282.434351312986;34145.82927085364;34867.82566087172;35084.12289692759;35141.297174056504;37198.256034879356;38280.80859595698;38576;38577.03557411066;38706.41940370897;7598.582077985709;7774.144844067148;7785.338246249047;7786.688532458695;7803.219678032208;7572;7701.8074548136465;7705.653245603961;7765.728199513018;7896.842063158733;7828.608569571527;7839.25527074927;7887.960560197191;7900.80247993799;7927.563983980907;7741.8838717419285;7774.611269436562;7787.338076263524;7799.649015794274;7850.057993040815;7612.238776122344;7699.191584883619;7763.805904852424;7769.844603107963;7820;37720.811395942845;37954.24091518182;37964.62035379638;38366.424503632465;38437.61562384368;2888.0758157389646;2918.8540572971265;3157.168842071593;3332.183615014337;3543.6102028776813;28479.20657726698;29203.70796292031;29327.85336073306;29472.557911631342;29512;3387.7120444762227;3426.674465925758;3433.5193072969805;3471.3577988072034;3498.265364273506;232114;232591;232717;233618;233704;33126.668733312355;52327.73836130795;52941.7352913233;53211;53339.733301333246;32109.23399213019;32436.83781581077;32440.35119297601;32586.511202331985;32618.673813262038;11598;11744.354060526583;11758.706032349088;11782.587609433629;11782.587609433629;10235.334703244265;10278.743031424125;10316.381017138845;10332.948335258427;10337.74155646115;8022.638981245858;8096.149904259968;8144.83710325802;8222.671093156327;8282.047564530036;3172.6985936336473;3205.5031470122167;3234.822084785312;3239.271163988084;3242.0922141800334;886;906.7733066733317;983.7393090830935;1029.8609687692215;1056.8784589772274;27948.860255698997;28042.2989425266;28310.85844570805;28348.291292717433;28567.428651426853;961.7307153996892;996.9601215951426;997.0627610046533;1054;1079.3955384984433;13417.262050587311;13659.043866929418;13781.724365512835;13862.306884655727;14042.789358159636;329812;335350;335424;336188;336825;48077;48464;48717;48928;48981.26528102082;1203.3622180244483;1224.1736827641307;1256.7737807194792;1257.911946163778;1284.991281843748;25180.49639007173;26271.605925910746;26352;26703.599446008713;26725.732742673103;41071.7946410278;41610;41797.37303940504;41824.79087604542;41880.3717944225;329880;332056;332666;333321;333521;25015;25588;25986.87006564955;26125.346866328495;26144.60783088293;40237;40679.59320406758;41341.37987930123;41901.371479427224;41993.16013679648;35491.64508354987;35720.464193036605;35979.640203598676;35986.64013359938;36111.63888361188;35037.649623503436;35499.82250088733;35662.64337356593;35747.46378804372;35909;34003;34526.654733453346;34584.65415345814;34662.13344666403;35243.82378088093;29808.552871707376;31705.365892681555;31812.204694881886;31949.68050319467;32149.839250803598;24874.25377238686;25043.624345634467;25091.498170036863;25176.622350664387;25528.23415297544 05:42:44 INFO - PROCESS | 24737 | |2;jquery.html;374.9418840079788;378.3190257536435;380.9276237514872;387.68403750942963;391.4832421204012;15411.306491207895;15886.761698574515;16866.915665421686;16894.324227030906;16908.915455422735;10757.193210509224;10813.405262710567;10827.404492752896;10848.457577121133;10893.128549716024;4595.862124136282;4602.7008244464005;4753.239481682931;4783.784729687172;4807.735574543399;4650.8604741857625;4700.694454860441;4704.482506924235;4713.340132381452;4732.574068333849;4535.863924082283;4717.292406139072;4731.172044892147;4742.312364707115;5169.966006798637;5142.897142057175;5153.175491921274;5168.043911876296;5180.45605211453;5180.7150606716805;4528.8867778305475;4554.8861278467975;4568.748718820463;4612.192866248393;4623.006053698437;12306.26162430248;12383.257004579755;12390.876091239063;12420.378981050912;12451.252924824448;1743.5379624399545;1837.2283640870733;1936.9225230990744;2033.6949457581334;2361.9645705314433;9422.717318480456;9452.621895124186;9472.810543789155;9610.615575376976;9681.951590242074;1692.5514738594281;1747.0915124135506;1763.0391436667048;1769.0712376002573;1776.316118294453;65807;68626;70101.2989870105;70666;70729.2927070733;10224.233182511342;10284.177265818716;10336.328138671113;10503.159747220205;10551.683449496528;14172.220527871066;14257.287135643177;14264.42942282297;14275.286235688174;14276.500322488662;6859.9314006860295;7082.5396349237135;7107.466939979522;7179.497435179487;7214.206437291894;6489.837754056092;6553.672316384162;6607.141071660653;6706.966465167643;6724.260331363546;4391.143726973273;4397.538258482878;4418.5802348776815;4480.507144214133;4545.068261006551;1833.1659095111693;1900.4963684623585;1910.522369407648;1917.5493758966632;1940.689489681644;814.3566582399956;843.8649816029406;846.327169899931;868.700298397052;976.8827740671165;15671.764923526156;15887.841121588635;15898.18923132281;16089.436869709738;16332.101734404721;837.6806529715722;869.6912596028445;901.1934318784782;903.5437104262305;916.812053529025;8985.011648718635;8988.235999940078;9127;9342.439453632804;9358.204552613104;405825;413233;414705;416465;418817;59047.70476147592;73938;78227.21772782312;79797.20202797897;80034.59982700166;886.2732559301311;892.2237653241722;902.1069141549949;905.0677801864091;909.9181073703398;14905.329260183535;14917.47788827386;14921.850781492047;15097.320620571882;15803.130827804582;24554.631680525163;25622.871885640452;35616.82191589026;36779.81610091932;37461.250774983804;41663.7916810414;44445.11109777851;45168.09663806771;46178.53821461877;51830.48169518256;10165.339252948535;11025.724356891142;11227.607033753779;11563.768724625628;11625.825612615648;12593;12672.746545068863;12675.619731408073;12915.22508649484;13007.674808129872;6010.849728756816;9549.90450095518;10763.838542421714;10982.835257471304;11009.174311926477;10908.836367454653;11024.44877756125;11064.225504214628;11115.610953616584;11403.372814495282;10250.794984100425;10538.833593156727;11077.058450031838;11163.330200188015;11424.371659558472;11522.711932201762;11544.942275288906;11619.477123529292;11703;11816.231944923553;10929.836052459379;10983.61557345521;11082.390468524309;11118.110551156049;11211.159163062639 05:42:44 INFO - PROCESS | 24737 | |3;mootools.html;1435.9928200359;1448.2396741710604;1603.3025633849277;1724.741288806678;1752.2377765671943;6993.720251189946;7394.223606521318;7575.810604734885;7886.487378320412;7894.052713674353;7650.693972241118;7651.617419129049;7673.808154796133;7691.077070751504;7772.378209743221;2266.002958698172;2299.1608063057033;2306.0199415248535;2309.9191528296515;2322.222055611372;2271.716035495563;2273.6816845641624;2308.8614683119067;2309.307207837642;2318;2295.82781291403;2312.8496647717843;2323.105604342332;2351.7295511016196;2356.387339291788;2230.096810791632;2260.8078313343385;2261.2198791417018;2262.3552287597954;2262.4343914021497;2218.9778102218934;2276.237460450751;2278;2279.920202792911;2283.6346184610384;7718.614069296513;7813.882791758128;7840.529568225925;7845.882311765328;7856.017997750281;4675.485696573374;4745.16959532084;4768.237082066853;4789.856304310876;4791.185498465269;2823.265950852793;2920.255334889611;2999.145243605584;3010.834404107773;3038.3923215356795;1022.5551884930079;1022.8721409823772;1022.8977102289786;1028.83024300991;1028.876534815827;10608.09831164352;10612.41631710248;10642.946785266024;10672.359658420519;10692.144628429707;4258.68059895509;4360.542143074995;4516.503184649686;4535.841245556389;4641.976790116028;9084.682036128705;9096.998660294725;9112.544372781334;9141.497217653094;9199.540022998823;4790.520947905251;4792;4817.807287708522;4839.274108883696;4849.854504364875;3766.9058273542832;4078.490188726409;4251.128518653669;4365.301551751704;4390.473143222834;3722.7021838252876;3786.9431958520645;3813.7033408641196;3820.1213720843807;3854.614538546179;1247.4760600547793;1266.2143284773535;1267.1763353819906;1268.6257554021586;1275.4515558309831;775.806048487878;775.8138046868711;792.3106896999648;794.527256282511;804.766617680866;5089.262057001714;5270.683758974474;5296.841094767163;5313.840584782462;5376.327959005124;423.45585922089964;432.48966219860864;435.44698233243605;440.67830483746405;442.31441266038155;3574.857005719742;3613.403788374941;3687.94468082979;3692.9076773080888;3711.4432835074413;9285.48929808867;9607.327487075978;9631.951840240754;9658.75853103664;9733.2213422926;9011.414258073204;9338.95330523343;9476.384035037701;9519.714408567754;9567.521623918776;7034.859302813813;7152.821179470555;7337.41300695943;7341.229170937081;7380.372668323145;5248.685078895279;5381.381141168816;5387.0572649785345;5387.599224201657;5395.946040539544;8927.464352138892;8953.641854326015;9095.408798428081;9123.315751318545;9253.398529095588;8755.781105472413;8965.596548155218;9052.547372631474;9198.67804626835;9247.861282080908;6142.78500252489;6526.151600291932;6679.899801503078;6795.354441328066;6874.415674667709;7292.088488938883;7332.963335183504;7336.889946650911;7398.630068496446;7410.740624078347;6557.442617377576;6700.597964122168;6711.597304161571;6744.898826517508;6758.526903116931;6581.111549940697;6595.868082638224;6642.5018123641885;6645;6683.398494135551;6128.9693551531955;6136.355682653436;6183.474404675473;6192.907106393498;6199.318075011655;4352.064306174188;4427.070315233837;4445.222086134849;4510.120526497432;4529.7282163069;4412.492563355255;4423.203823311835;4440.311751678495;4457.68796184264;4474.664400169935 05:42:44 INFO - PROCESS | 24737 | |4;prototype.html;316.47149260734574;319.83048984038453;321.82943040188707;324.1862924060607;324.8521922525251;5411;5473.288472498574;5485.396606373306;5486.91769623456;5510.256115424417;5376.51611354978;5387.676739395639;5396.384422436967;5418.187271909215;5421.376541697706;3945.132070944395;4014.257362387953;4139.751614903101;4160.313548264533;4168.958310416887;4185.707000509966;4192.203481338536;4192.392103145042;4195.7063005589625;4197.265478541259;4160.1471698301775;4162.43807086044;4168.583141685837;4170.22850772608;4172.499300083994;4078.388241763744;4139.648129908961;4154.273002224599;4169.185799585298;4173.603507666767;3595.82020898954;3610.9277814443826;3621.3481573316794;3629.8185090745355;3649.069487280753;5055.9241611375855;5104.438511763703;5113.974430127862;5139.61452891031;5180.481951804827;4493.146302202571;4736.881577960544;4753.168195565762;4771.355866957951;4798.616110711169;5677.7289084366175;5678.119891416837;5678.545716342724;5680.11958146488;5693.202951586781;3897.5907529709257;3936.881893543198;3939.4484772131923;3943.743656662308;3950.1902110067367;5865.970670146665;5979.1629171915965;5993.374008724702;6038;6043.093535969596;3989.5810939851476;4005.2990726622725;4010.5588385277597;4024.6176613222283;4042.6361627453084;4067;4073.103917138225;4090.7545547266664;4093.079057212163;4104.501856822298;4578;4714.528547145258;4722.95277047232;4743.644226682944;4752.1683705351425;5711.857203569944;5719.571032172604;5720.742566584514;5730.226419433407;5754.367019627837;1396.7276381105587;1406.374163497234;1409.9083559568596;1412.8092707484564;1416.3130881522454;864.1185990289869;921.4655499810228;940.7365937537501;966.2801213096288;966.9371490853072;4822.590079843252;4873.731944743002;4874.122657921608;4875.902481950341;4904.485029071968;5831.154482599999;5864.296284445893;5872.207252020922;5874.03078492044;5937.812437512514;4708.788104535304;4870.342503762017;4888;4924.35983322173;4943.653944223942;3153.952690709641;3224.1783392383227;3227.370662720794;3232.369687910882;3235.5955505561806;5574.442555744393;5582.944170558242;5584.636998595079;5586.636868603528;5589.972050139723;5886.646801191942;6135.693215339215;6137.631742095488;6152.031349967967;6169.2288463942;5527.917081243865;5553.278073850373;5563.888722225533;5589.133684278943;5590.972045139748;5670.144301874765;5955;5958.374370691015;5970.880582388415;6040.6677632730625;5876.1773351729935;5894.646321220741;5900.881982360243;5919.200907877382;5921.3190483094995;5568.415316391883;5594.860128496657;5601.41185175567;5603.327600687943;5611;3887.125396785814;4075.4498142751536;4100.692448066347;4102.405151253111;4117.197146556393;5949.52403807703;5967.134765459071;5983.431574000463;5995.190649262294;6013.872786151264;5598.804041858678;5737.168110624019;5744.109663002241;5787.56593255516;5796.1305804129715;5722.6852523109965;5780.410387143401;5815.680137592473;5819.127130930395;5823.155642431909;5354.678719276856;5701.914471283017;5708.714564271687;5716.342620598684;5718.1708652246025;5643.943560564506;5826.912596310974;5829.679367634821;5840.240768700041;5874.265716785402;5662.320521537442;5668.149777533238;5669.829905102853;5674;5686.800961966312 05:42:44 INFO - PROCESS | 24737 | |5;yui.html;588.3778077735092;624.6658037949697;709.1915216653014;735.1215297719224;748.3601520699801;11772.882271177286;11830;12286.262824230542;12395.318257495834;12977.740445191113;12680.936595317033;12683.61949141525;12793.872061279384;12836.0372972027;12843.35783210838;618.1222663817367;762.9351505122044;781.3319611731959;792.9484583502054;797.7686470923426;788.5505262000662;792.6195426195429;794.6900708723603;800.747764454198;800.9839803203932;819.2954059508818;824.085265355455;826.983460330793;828.2752591482453;829.9751007469755;821.1008945204991;821.3962737388015;830.0827585517976;830.8006078541137;831.6756464978663;607.3683369295927;607.6566739792004;608.656109298245;608.7108623403892;610.3560743415694;12392.504299827997;12405;12498.562550310695;12508.061895357885;12556.121071524996;12567.622971310875;12576.11967162299;12582.496700131984;12884.226946383247;13034.087613867034;9952.104310612007;10059.195264378905;10142.239332050052;10378.896211037943;10573.894261057369;3358.7648864579487;3377.8986630401128;3390.542276792626;3397.13373089863;3474.7567670263093;49885.25172122421;50062.49937500651;50409.47133700643;50685.74657126691;50808;9234.81530369389;9386;9404.764880877896;9470.768800056087;9534.189593884597;16953.541736448147;17069;17091.059991700327;17104.230309636096;17146.828531714524;6943.652817359111;7008.614526201108;7035.7185712571945;7105.538140020882;7113.502054856214;3654.4518322251342;3806.0865392305645;3855.4602355670227;3869.9806500967316;3896.7077469189926;2864.7278508541654;2872.971270287312;2888.1479963410843;2894.9276268093045;2898.2899189698237;488.67747286790546;506.6250974279081;510.6859281541825;514;520.7188118416013;573.8708790522182;586.7711592478937;606.6481440764346;612.5467154305782;614.4562062574654;7312.378447831994;7407.85184296311;7413.555186688816;7431.368333691588;7752.961235193788;466.93696350992184;488.5261296542348;489.47626040136714;493.4843088972033;506.9949300506948;2885.1488810800865;2921.1382642120625;2923.8391888445913;2931.0620601407345;2962.8074175178544;42004;48947.510524895006;49246.50753492419;53776.73111634417;54542.727286364105;40049.39925901114;40527.1894562113;40742.9814254646;41055.178896422505;42650.78674606669;40323.395149072785;41017.384739228335;41289.38065929014;41356;42465.36301955473;7096.503244772816;7377.1885092638695;7426.888596670946;7495.43784216175;7595.5442673439775;28323.858380707963;29344.41311173807;29764.85117574398;29824.850875745484;30095.849520752257;37203.255934881694;39061;39746.80126599464;39997.40003900002;40083.799581001906;9892.109710126124;9937.304388693012;10039.949800250952;10155.54300056514;10320.896791031993;10717.14262858985;10790.406527640742;10951.945240273748;11098;11113.110951124052;9006.59470323824;9211.723648290563;9312.627494900398;9403.717888463358;9591.328606997444;9771.609135634779;9851.261155413229;9880.752981175528;9991.650292239738;10160.745981350525;10115.342502737298;10135.79728405413;10142.29003969715;10206.897931020594;10229.48852557384;8210.83578328442;8522.914770852212;8568.400211985101;8591.957040214758;9053.049429809775;8407.411481196257;8456.492610443393;8694.391392602458;8782.516961567175;8804.295656347605 05:42:44 INFO - PROCESS | 24737 | __end_tp_report 05:42:44 INFO - PROCESS | 24737 | __start_cc_report 05:42:44 INFO - PROCESS | 24737 | _x_x_mozilla_cycle_collect,358 05:42:44 INFO - PROCESS | 24737 | __end_cc_report 05:42:44 INFO - PROCESS | 24737 | __startTimestamp1461588164402__endTimestamp 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | ------- Summary: start ------- 05:42:44 INFO - PROCESS | 24737 | Number of tests: 6 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#0] dojo.html Cycles:165 Average:4755.07 Median:4897.82 stddev:506.29 (10.3%) stddev-sans-first:479.57 05:42:44 INFO - PROCESS | 24737 | Values: 2628.5 2687.2 2695.4 2719.2 2727.7 4686.6 4713.2 4728.7 4772.3 4782.2 4687.6 4743.8 4838.2 4891.0 4904.0 4430.1 4465.6 4499.2 4509.3 4553.5 4458.5 4487.9 4501.3 4529.5 4532.1 4337.1 4381.7 4401.4 4447.0 4451.7 4324.7 4347.3 4359.3 4360.4 4411.0 4372.5 4384.4 4393.2 4393.8 4432.7 4648.7 4685.1 4718.0 4737.6 4750.9 5011.9 5024.1 5079.5 5102.6 5107.4 5112.1 5133.9 5139.8 5145.2 5224.2 4876.1 4886.1 4897.8 4899.2 4948.3 5318.9 5375.6 5382.9 5389.3 5447.5 4981.3 5051.2 5123.3 5148.1 5151.7 5187.8 5188.8 5198.7 5203.8 5239.9 4979.8 5078.3 5147.9 5173.2 5180.4 5024.9 5081.0 5086.6 5088.0 5099.3 4315.2 4315.3 4328.2 4353.1 4361.0 3753.2 3757.2 3779.8 3801.4 3826.6 4280.4 4377.2 4386.3 4423.7 4456.9 5125.9 5150.4 5150.7 5151.0 5198.4 4401.6 4405.7 4410.8 4462.9 4469.2 4556.8 4600.3 4631.1 4719.5 4720.8 4844.4 4872.8 4889.0 4906.3 4977.1 5220.2 5258.9 5266.3 5281.9 5293.9 4749.3 4817.2 4855.2 4889.8 4900.9 5041.9 5074.3 5076.3 5076.9 5123.4 5051.6 5151.8 5154.6 5157.4 5179.0 4849.9 4983.4 5000.0 5033.9 5049.8 4947.8 4952.8 5006.8 5014.8 5026.4 4876.0 4890.0 4922.7 4931.0 4980.7 5016.2 5042.3 5042.9 5066.3 5100.8 4894.6 4924.8 4933.5 4939.7 4951.8 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#1] ext.html Cycles:180 Average:44204.43 Median:34555.65 stddev:79971.46 (231.4%) stddev-sans-first:80128.72 05:42:44 INFO - PROCESS | 24737 | Values: 578.9 597.3 601.1 622.0 628.3 28282.4 34145.8 34867.8 35084.1 35141.3 37198.3 38280.8 38576.0 38577.0 38706.4 7598.6 7774.1 7785.3 7786.7 7803.2 7572.0 7701.8 7705.7 7765.7 7896.8 7828.6 7839.3 7888.0 7900.8 7927.6 7741.9 7774.6 7787.3 7799.6 7850.1 7612.2 7699.2 7763.8 7769.8 7820.0 37720.8 37954.2 37964.6 38366.4 38437.6 2888.1 2918.9 3157.2 3332.2 3543.6 28479.2 29203.7 29327.9 29472.6 29512.0 3387.7 3426.7 3433.5 3471.4 3498.3 232114.0 232591.0 232717.0 233618.0 233704.0 33126.7 52327.7 52941.7 53211.0 53339.7 32109.2 32436.8 32440.4 32586.5 32618.7 11598.0 11744.4 11758.7 11782.6 11782.6 10235.3 10278.7 10316.4 10332.9 10337.7 8022.6 8096.1 8144.8 8222.7 8282.0 3172.7 3205.5 3234.8 3239.3 3242.1 886.0 906.8 983.7 1029.9 1056.9 27948.9 28042.3 28310.9 28348.3 28567.4 961.7 997.0 997.1 1054.0 1079.4 13417.3 13659.0 13781.7 13862.3 14042.8 329812.0 335350.0 335424.0 336188.0 336825.0 48077.0 48464.0 48717.0 48928.0 48981.3 1203.4 1224.2 1256.8 1257.9 1285.0 25180.5 26271.6 26352.0 26703.6 26725.7 41071.8 41610.0 41797.4 41824.8 41880.4 329880.0 332056.0 332666.0 333321.0 333521.0 25015.0 25588.0 25986.9 26125.3 26144.6 40237.0 40679.6 41341.4 41901.4 41993.2 35491.6 35720.5 35979.6 35986.6 36111.6 35037.6 35499.8 35662.6 35747.5 35909.0 34003.0 34526.7 34584.7 34662.1 35243.8 29808.6 31705.4 31812.2 31949.7 32149.8 24874.3 25043.6 25091.5 25176.6 25528.2 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#2] jquery.html Cycles:180 Average:24392.05 Median:384.31 stddev:68095.45 (17719.1%) stddev-sans-first:68262.59 05:42:44 INFO - PROCESS | 24737 | Values: 374.9 378.3 380.9 387.7 391.5 15411.3 15886.8 16866.9 16894.3 16908.9 10757.2 10813.4 10827.4 10848.5 10893.1 4595.9 4602.7 4753.2 4783.8 4807.7 4650.9 4700.7 4704.5 4713.3 4732.6 4535.9 4717.3 4731.2 4742.3 5170.0 5142.9 5153.2 5168.0 5180.5 5180.7 4528.9 4554.9 4568.7 4612.2 4623.0 12306.3 12383.3 12390.9 12420.4 12451.3 1743.5 1837.2 1936.9 2033.7 2362.0 9422.7 9452.6 9472.8 9610.6 9682.0 1692.6 1747.1 1763.0 1769.1 1776.3 65807.0 68626.0 70101.3 70666.0 70729.3 10224.2 10284.2 10336.3 10503.2 10551.7 14172.2 14257.3 14264.4 14275.3 14276.5 6859.9 7082.5 7107.5 7179.5 7214.2 6489.8 6553.7 6607.1 6707.0 6724.3 4391.1 4397.5 4418.6 4480.5 4545.1 1833.2 1900.5 1910.5 1917.5 1940.7 814.4 843.9 846.3 868.7 976.9 15671.8 15887.8 15898.2 16089.4 16332.1 837.7 869.7 901.2 903.5 916.8 8985.0 8988.2 9127.0 9342.4 9358.2 405825.0 413233.0 414705.0 416465.0 418817.0 59047.7 73938.0 78227.2 79797.2 80034.6 886.3 892.2 902.1 905.1 909.9 14905.3 14917.5 14921.9 15097.3 15803.1 24554.6 25622.9 35616.8 36779.8 37461.3 41663.8 44445.1 45168.1 46178.5 51830.5 10165.3 11025.7 11227.6 11563.8 11625.8 12593.0 12672.7 12675.6 12915.2 13007.7 6010.8 9549.9 10763.8 10982.8 11009.2 10908.8 11024.4 11064.2 11115.6 11403.4 10250.8 10538.8 11077.1 11163.3 11424.4 11522.7 11544.9 11619.5 11703.0 11816.2 10929.8 10983.6 11082.4 11118.1 11211.2 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#3] mootools.html Cycles:180 Average:5147.29 Median:4791.59 stddev:2843.16 (59.3%) stddev-sans-first:2837.45 05:42:44 INFO - PROCESS | 24737 | Values: 1436.0 1448.2 1603.3 1724.7 1752.2 6993.7 7394.2 7575.8 7886.5 7894.1 7650.7 7651.6 7673.8 7691.1 7772.4 2266.0 2299.2 2306.0 2309.9 2322.2 2271.7 2273.7 2308.9 2309.3 2318.0 2295.8 2312.8 2323.1 2351.7 2356.4 2230.1 2260.8 2261.2 2262.4 2262.4 2219.0 2276.2 2278.0 2279.9 2283.6 7718.6 7813.9 7840.5 7845.9 7856.0 4675.5 4745.2 4768.2 4789.9 4791.2 2823.3 2920.3 2999.1 3010.8 3038.4 1022.6 1022.9 1022.9 1028.8 1028.9 10608.1 10612.4 10642.9 10672.4 10692.1 4258.7 4360.5 4516.5 4535.8 4642.0 9084.7 9097.0 9112.5 9141.5 9199.5 4790.5 4792.0 4817.8 4839.3 4849.9 3766.9 4078.5 4251.1 4365.3 4390.5 3722.7 3786.9 3813.7 3820.1 3854.6 1247.5 1266.2 1267.2 1268.6 1275.5 775.8 775.8 792.3 794.5 804.8 5089.3 5270.7 5296.8 5313.8 5376.3 423.5 432.5 435.4 440.7 442.3 3574.9 3613.4 3687.9 3692.9 3711.4 9285.5 9607.3 9632.0 9658.8 9733.2 9011.4 9339.0 9476.4 9519.7 9567.5 7034.9 7152.8 7337.4 7341.2 7380.4 5248.7 5381.4 5387.1 5387.6 5395.9 8927.5 8953.6 9095.4 9123.3 9253.4 8755.8 8965.6 9052.5 9198.7 9247.9 6142.8 6526.2 6679.9 6795.4 6874.4 7292.1 7333.0 7336.9 7398.6 7410.7 6557.4 6700.6 6711.6 6744.9 6758.5 6581.1 6595.9 6642.5 6645.0 6683.4 6129.0 6136.4 6183.5 6192.9 6199.3 4352.1 4427.1 4445.2 4510.1 4529.7 4412.5 4423.2 4440.3 4457.7 4474.7 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#4] prototype.html Cycles:180 Average:4718.66 Median:5419.78 stddev:1411.12 (26.0%) stddev-sans-first:1375.85 05:42:44 INFO - PROCESS | 24737 | Values: 316.5 319.8 321.8 324.2 324.9 5411.0 5473.3 5485.4 5486.9 5510.3 5376.5 5387.7 5396.4 5418.2 5421.4 3945.1 4014.3 4139.8 4160.3 4169.0 4185.7 4192.2 4192.4 4195.7 4197.3 4160.1 4162.4 4168.6 4170.2 4172.5 4078.4 4139.6 4154.3 4169.2 4173.6 3595.8 3610.9 3621.3 3629.8 3649.1 5055.9 5104.4 5114.0 5139.6 5180.5 4493.1 4736.9 4753.2 4771.4 4798.6 5677.7 5678.1 5678.5 5680.1 5693.2 3897.6 3936.9 3939.4 3943.7 3950.2 5866.0 5979.2 5993.4 6038.0 6043.1 3989.6 4005.3 4010.6 4024.6 4042.6 4067.0 4073.1 4090.8 4093.1 4104.5 4578.0 4714.5 4723.0 4743.6 4752.2 5711.9 5719.6 5720.7 5730.2 5754.4 1396.7 1406.4 1409.9 1412.8 1416.3 864.1 921.5 940.7 966.3 966.9 4822.6 4873.7 4874.1 4875.9 4904.5 5831.2 5864.3 5872.2 5874.0 5937.8 4708.8 4870.3 4888.0 4924.4 4943.7 3154.0 3224.2 3227.4 3232.4 3235.6 5574.4 5582.9 5584.6 5586.6 5590.0 5886.6 6135.7 6137.6 6152.0 6169.2 5527.9 5553.3 5563.9 5589.1 5591.0 5670.1 5955.0 5958.4 5970.9 6040.7 5876.2 5894.6 5900.9 5919.2 5921.3 5568.4 5594.9 5601.4 5603.3 5611.0 3887.1 4075.4 4100.7 4102.4 4117.2 5949.5 5967.1 5983.4 5995.2 6013.9 5598.8 5737.2 5744.1 5787.6 5796.1 5722.7 5780.4 5815.7 5819.1 5823.2 5354.7 5701.9 5708.7 5716.3 5718.2 5643.9 5826.9 5829.7 5840.2 5874.3 5662.3 5668.1 5669.8 5674.0 5686.8 05:42:44 INFO - PROCESS | 24737 | 05:42:44 INFO - PROCESS | 24737 | [#5] yui.html Cycles:180 Average:12406.02 Median:25189.37 stddev:14243.94 (56.5%) stddev-sans-first:14256.25 05:42:44 INFO - PROCESS | 24737 | Values: 588.4 624.7 709.2 735.1 748.4 11772.9 11830.0 12286.3 12395.3 12977.7 12680.9 12683.6 12793.9 12836.0 12843.4 618.1 762.9 781.3 792.9 797.8 788.6 792.6 794.7 800.7 801.0 819.3 824.1 827.0 828.3 830.0 821.1 821.4 830.1 830.8 831.7 607.4 607.7 608.7 608.7 610.4 12392.5 12405.0 12498.6 12508.1 12556.1 12567.6 12576.1 12582.5 12884.2 13034.1 9952.1 10059.2 10142.2 10378.9 10573.9 3358.8 3377.9 3390.5 3397.1 3474.8 49885.3 50062.5 50409.5 50685.7 50808.0 9234.8 9386.0 9404.8 9470.8 9534.2 16953.5 17069.0 17091.1 17104.2 17146.8 6943.7 7008.6 7035.7 7105.5 7113.5 3654.5 3806.1 3855.5 3870.0 3896.7 2864.7 2873.0 2888.1 2894.9 2898.3 488.7 506.6 510.7 514.0 520.7 573.9 586.8 606.6 612.5 614.5 7312.4 7407.9 7413.6 7431.4 7753.0 466.9 488.5 489.5 493.5 507.0 2885.1 2921.1 2923.8 2931.1 2962.8 42004.0 48947.5 49246.5 53776.7 54542.7 40049.4 40527.2 40743.0 41055.2 42650.8 40323.4 41017.4 41289.4 41356.0 42465.4 7096.5 7377.2 7426.9 7495.4 7595.5 28323.9 29344.4 29764.9 29824.9 30095.8 37203.3 39061.0 39746.8 39997.4 40083.8 9892.1 9937.3 10039.9 10155.5 10320.9 10717.1 10790.4 10951.9 11098.0 11113.1 9006.6 9211.7 9312.6 9403.7 9591.3 9771.6 9851.3 9880.8 9991.7 10160.7 10115.3 10135.8 10142.3 10206.9 10229.5 8210.8 8522.9 8568.4 8592.0 9053.0 8407.4 8456.5 8694.4 8782.5 8804.3 05:42:44 INFO - PROCESS | 24737 | -------- Summary: end -------- 05:42:44 INFO - PROCESS | 24737 | 05:42:45 INFO - TEST-INFO | 24737: exit 0 05:42:45 INFO - TEST-OK | dromaeo_css | took 1115188ms 05:42:45 INFO - TEST-START | kraken 05:42:45 INFO - operating with platform_type : linux_ 05:42:45 INFO - Initialising browser for kraken test... 05:42:45 INFO - TEST-INFO | started process 24971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTm65h/profile http://localhost:57746/getInfo.html) 05:42:49 INFO - PROCESS | 24971 | 05:42:49 INFO - PROCESS | 24971 | (process:25038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:42:50 INFO - PROCESS | 24971 | __metrics Screen width/height:1600/1200 05:42:50 INFO - PROCESS | 24971 | colorDepth:24 05:42:50 INFO - PROCESS | 24971 | Browser inner width/height: 1024/697 05:42:50 INFO - PROCESS | 24971 | __metrics 05:42:50 ERROR - PROCESS | 24971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:42:51 INFO - TEST-INFO | 24971: exit 0 05:42:51 INFO - Browser initialized. 05:42:51 INFO - Running cycle 1/1 for kraken test... 05:42:51 INFO - TEST-INFO | started process 25089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTm65h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:53 INFO - PROCESS | 25089 | 05:42:53 INFO - PROCESS | 25089 | (process:25149): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:03 INFO - PROCESS | 25089 | RSS: Main: 165326848 05:43:03 INFO - PROCESS | 25089 | 05:43:06 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57746/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:07 INFO - PROCESS | 25089 | RSS: Main: 169873408 05:43:07 INFO - PROCESS | 25089 | 05:43:10 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57746/tests/kraken/driver.html?testName=audio-dft) 05:43:10 INFO - PROCESS | 25089 | RSS: Main: 173121536 05:43:10 INFO - PROCESS | 25089 | 05:43:13 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57746/tests/kraken/driver.html?testName=audio-fft) 05:43:14 INFO - PROCESS | 25089 | RSS: Main: 163278848 05:43:14 INFO - PROCESS | 25089 | 05:43:16 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57746/tests/kraken/driver.html?testName=audio-oscillator) 05:43:17 INFO - PROCESS | 25089 | RSS: Main: 163729408 05:43:17 INFO - PROCESS | 25089 | 05:43:19 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:19 INFO - PROCESS | 25089 | RSS: Main: 165568512 05:43:19 INFO - PROCESS | 25089 | 05:43:23 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57746/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:23 INFO - PROCESS | 25089 | RSS: Main: 166158336 05:43:23 INFO - PROCESS | 25089 | 05:43:27 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57746/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:27 INFO - PROCESS | 25089 | RSS: Main: 165089280 05:43:27 INFO - PROCESS | 25089 | 05:43:30 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57746/tests/kraken/driver.html?testName=json-parse-financial) 05:43:31 INFO - PROCESS | 25089 | RSS: Main: 165380096 05:43:31 INFO - PROCESS | 25089 | 05:43:33 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:33 INFO - PROCESS | 25089 | RSS: Main: 165736448 05:43:33 INFO - PROCESS | 25089 | 05:43:35 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:36 INFO - PROCESS | 25089 | RSS: Main: 165871616 05:43:36 INFO - PROCESS | 25089 | 05:43:38 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:39 INFO - PROCESS | 25089 | RSS: Main: 166170624 05:43:39 INFO - PROCESS | 25089 | 05:43:41 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:42 INFO - PROCESS | 25089 | RSS: Main: 166174720 05:43:42 INFO - PROCESS | 25089 | 05:43:45 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:46 INFO - PROCESS | 25089 | RSS: Main: 166248448 05:43:46 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | Cycle 1(1): loaded http://localhost:57746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57746/tests/kraken/driver.html?testName=ai-astar) 05:43:48 INFO - PROCESS | 25089 | RSS: Main: 167731200 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | __start_tp_report 05:43:48 INFO - PROCESS | 25089 | _x_x_mozilla_page_load 05:43:48 INFO - PROCESS | 25089 | _x_x_mozilla_page_load_details 05:43:48 INFO - PROCESS | 25089 | |i|pagename|runs| 05:43:48 INFO - PROCESS | 25089 | |0;ai-astar;114;109;113;113;113;126;112;113;112;115 05:43:48 INFO - PROCESS | 25089 | |1;audio-beat-detection;158;136;161;181;139;158;162;143;204;133 05:43:48 INFO - PROCESS | 25089 | |2;audio-dft;163;167;164;169;166;164;163;166;165;163 05:43:48 INFO - PROCESS | 25089 | |3;audio-fft;76;74;77;155;74;76;77;73;163;76 05:43:48 INFO - PROCESS | 25089 | |4;audio-oscillator;95;94;138;94;94;93;135;94;94;144 05:43:48 INFO - PROCESS | 25089 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;117;119;118 05:43:48 INFO - PROCESS | 25089 | |6;imaging-darkroom;148;147;147;149;148;148;147;148;148;148 05:43:48 INFO - PROCESS | 25089 | |7;imaging-desaturate;95;95;96;95;94;96;96;97;96;95 05:43:48 INFO - PROCESS | 25089 | |8;json-parse-financial;67;66;68;66;69;67;71;83;63;63 05:43:48 INFO - PROCESS | 25089 | |9;json-stringify-tinderbox;64;64;65;64;65;64;64;63;68;65 05:43:48 INFO - PROCESS | 25089 | |10;stanford-crypto-aes;80;88;79;83;82;81;80;80;81;81 05:43:48 INFO - PROCESS | 25089 | |11;stanford-crypto-ccm;144;135;149;137;135;133;138;138;174;142 05:43:48 INFO - PROCESS | 25089 | |12;stanford-crypto-pbkdf2;183;176;184;181;180;184;178;173;180;186 05:43:48 INFO - PROCESS | 25089 | |13;stanford-crypto-sha256-iterative;72;73;74;74;74;74;71;72;72;72 05:43:48 INFO - PROCESS | 25089 | __end_tp_report 05:43:48 INFO - PROCESS | 25089 | __start_cc_report 05:43:48 INFO - PROCESS | 25089 | _x_x_mozilla_cycle_collect,891 05:43:48 INFO - PROCESS | 25089 | __end_cc_report 05:43:48 INFO - PROCESS | 25089 | __startTimestamp1461588228310__endTimestamp 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | ------- Summary: start ------- 05:43:48 INFO - PROCESS | 25089 | Number of tests: 14 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 05:43:48 INFO - PROCESS | 25089 | Values: 114.0 109.0 113.0 113.0 113.0 126.0 112.0 113.0 112.0 115.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#1] audio-beat-detection Cycles:10 Average:157.50 Median:159.50 stddev:22.02 (13.8%) stddev-sans-first:23.35 05:43:48 INFO - PROCESS | 25089 | Values: 158.0 136.0 161.0 181.0 139.0 158.0 162.0 143.0 204.0 133.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:2.00 (1.2%) stddev-sans-first:1.99 05:43:48 INFO - PROCESS | 25089 | Values: 163.0 167.0 164.0 169.0 166.0 164.0 163.0 166.0 165.0 163.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:35.33 (46.5%) stddev-sans-first:36.99 05:43:48 INFO - PROCESS | 25089 | Values: 76.0 74.0 77.0 155.0 74.0 76.0 77.0 73.0 163.0 76.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:21.85 (23.2%) stddev-sans-first:22.70 05:43:48 INFO - PROCESS | 25089 | Values: 95.0 94.0 138.0 94.0 94.0 93.0 135.0 94.0 94.0 144.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 05:43:48 INFO - PROCESS | 25089 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 119.0 118.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:43:48 INFO - PROCESS | 25089 | Values: 148.0 147.0 147.0 149.0 148.0 148.0 147.0 148.0 148.0 148.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 05:43:48 INFO - PROCESS | 25089 | Values: 95.0 95.0 96.0 95.0 94.0 96.0 96.0 97.0 96.0 95.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:67.50 stddev:5.72 (8.5%) stddev-sans-first:6.04 05:43:48 INFO - PROCESS | 25089 | Values: 67.0 66.0 68.0 66.0 69.0 67.0 71.0 83.0 63.0 63.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 05:43:48 INFO - PROCESS | 25089 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 64.0 63.0 68.0 65.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.55 (3.1%) stddev-sans-first:2.65 05:43:48 INFO - PROCESS | 25089 | Values: 80.0 88.0 79.0 83.0 82.0 81.0 80.0 80.0 81.0 81.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:12.07 (8.6%) stddev-sans-first:12.79 05:43:48 INFO - PROCESS | 25089 | Values: 144.0 135.0 149.0 137.0 135.0 133.0 138.0 138.0 174.0 142.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:182.00 stddev:4.01 (2.2%) stddev-sans-first:4.15 05:43:48 INFO - PROCESS | 25089 | Values: 183.0 176.0 184.0 181.0 180.0 184.0 178.0 173.0 180.0 186.0 05:43:48 INFO - PROCESS | 25089 | 05:43:48 INFO - PROCESS | 25089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.50 stddev:1.14 (1.5%) stddev-sans-first:1.17 05:43:48 INFO - PROCESS | 25089 | Values: 72.0 73.0 74.0 74.0 74.0 74.0 71.0 72.0 72.0 72.0 05:43:48 INFO - PROCESS | 25089 | -------- Summary: end -------- 05:43:48 INFO - PROCESS | 25089 | 05:43:49 INFO - TEST-INFO | 25089: exit 0 05:43:49 INFO - TEST-OK | kraken | took 64149ms 05:43:49 INFO - SUITE-END | took 1179s 05:43:49 INFO - Completed test suite (00:19:39) 05:43:49 INFO - javascript benchmark 05:43:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.4611654610803, 2687.2207059952607, 2695.380062585604, 2719.2114286856813, 2727.6590426196726, 4686.648501362403, 4713.245880659095, 4728.66899317048, 4772.260299653555, 4782.234842425212, 4687.554682305184, 4743.76281185941, 4838.153323168449, 4890.951090489094, 4904.0, 4430.1139772045635, 4465.642748580122, 4499.235130027903, 4509.323601459791, 4553.4991150973365, 4458.4872739634875, 4487.910241795178, 4501.324801279818, 4529.547045295477, 4532.116237333721, 4337.110892267109, 4381.693281470299, 4401.449818772653, 4446.977765111186, 4451.688381813275, 4324.740515569076, 4347.282698354799, 4359.302511598161, 4360.433143691332, 4411.0, 4372.497162826284, 4384.364267181273, 4393.187260356813, 4393.824247030115, 4432.71187372823, 4648.651351148644, 4685.1332503486965, 4717.952820471785, 4737.597304229144, 4750.904981900378, 5011.874703132415, 5024.145895197825, 5079.5428411443145, 5102.6428150029515, 5107.438181799999, 5112.105381558213, 5133.897322053575, 5139.820106296262, 5145.151050076733, 5224.242484839715, 4876.097921884428, 4886.120498310267, 4897.824522114667, 4899.191633380524, 4948.282499037656, 5318.946810531846, 5375.623706340597, 5382.91925621116, 5389.326334208224, 5447.4824891635235, 4981.302617633534, 5051.217061355495, 5123.2827404163445, 5148.124818780741, 5151.6908985461, 5187.818426355059, 5188.792448302102, 5198.662086964335, 5203.765830537559, 5239.895202095937, 4979.751012449363, 5078.263651770547, 5147.871303217449, 5173.1722924331925, 5180.352455943007, 5024.874378140503, 5080.974595127074, 5086.567641750418, 5087.97456012725, 5099.3370861787735, 4315.1585440838735, 4315.287977483743, 4328.177646247203, 4353.085851971058, 4361.018770776614, 3753.155540003477, 3757.1546402059867, 3779.848806047727, 3801.429785532137, 3826.598207188261, 4280.379344994958, 4377.16833801583, 4386.298192289219, 4423.712458690175, 4456.888577785517, 5125.897482050338, 5150.40770311419, 5150.690958542499, 5151.0, 5198.376194856642, 4401.625861801783, 4405.691601587858, 4410.757408342572, 4462.888427789331, 4469.150861336336, 4556.7721613919175, 4600.332951721982, 4631.0506346198945, 4719.457262414798, 4720.787564559603, 4844.370231869905, 4872.805087796449, 4888.951110488921, 4906.313116163811, 4977.0792403405485, 5220.1647736362, 5258.921116183184, 5266.289050978069, 5281.9471805281455, 5293.947060529345, 4749.3113498541825, 4817.205161148511, 4855.223164293696, 4889.804407823647, 4900.926486102782, 5041.924371134509, 5074.289599456005, 5076.314697515788, 5076.898462030665, 5123.359580052494, 5051.646384753032, 5151.8196863109615, 5154.639175257846, 5157.381114266312, 5179.0, 4849.878753031202, 4983.401991760867, 5000.0, 5033.874153146201, 5049.772760225872, 4947.752612369295, 4952.7771250294545, 5006.774695138654, 5014.799408023784, 5026.371703537058, 4876.0, 4890.0, 4922.680025798311, 4931.0, 4980.676256043345, 5016.247562865454, 5042.319286896369, 5042.873928151826, 5066.31604733371, 5100.770465329143, 4894.583960363267, 4924.82763103304, 4933.4819843915875, 4939.728314942713, 4951.8266860659705], "value": 4722.419649536875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8929048126097, 597.3041406761123, 601.0983524712931, 621.987560248795, 628.3025841316141, 28282.434351312986, 34145.82927085364, 34867.82566087172, 35084.12289692759, 35141.297174056504, 37198.256034879356, 38280.80859595698, 38576.0, 38577.03557411066, 38706.41940370897, 7598.582077985709, 7774.144844067148, 7785.338246249047, 7786.688532458695, 7803.219678032208, 7572.0, 7701.8074548136465, 7705.653245603961, 7765.728199513018, 7896.842063158733, 7828.608569571527, 7839.25527074927, 7887.960560197191, 7900.80247993799, 7927.563983980907, 7741.8838717419285, 7774.611269436562, 7787.338076263524, 7799.649015794274, 7850.057993040815, 7612.238776122344, 7699.191584883619, 7763.805904852424, 7769.844603107963, 7820.0, 37720.811395942845, 37954.24091518182, 37964.62035379638, 38366.424503632465, 38437.61562384368, 2888.0758157389646, 2918.8540572971265, 3157.168842071593, 3332.183615014337, 3543.6102028776813, 28479.20657726698, 29203.70796292031, 29327.85336073306, 29472.557911631342, 29512.0, 3387.7120444762227, 3426.674465925758, 3433.5193072969805, 3471.3577988072034, 3498.265364273506, 232114.0, 232591.0, 232717.0, 233618.0, 233704.0, 33126.668733312355, 52327.73836130795, 52941.7352913233, 53211.0, 53339.733301333246, 32109.23399213019, 32436.83781581077, 32440.35119297601, 32586.511202331985, 32618.673813262038, 11598.0, 11744.354060526583, 11758.706032349088, 11782.587609433629, 11782.587609433629, 10235.334703244265, 10278.743031424125, 10316.381017138845, 10332.948335258427, 10337.74155646115, 8022.638981245858, 8096.149904259968, 8144.83710325802, 8222.671093156327, 8282.047564530036, 3172.6985936336473, 3205.5031470122167, 3234.822084785312, 3239.271163988084, 3242.0922141800334, 886.0, 906.7733066733317, 983.7393090830935, 1029.8609687692215, 1056.8784589772274, 27948.860255698997, 28042.2989425266, 28310.85844570805, 28348.291292717433, 28567.428651426853, 961.7307153996892, 996.9601215951426, 997.0627610046533, 1054.0, 1079.3955384984433, 13417.262050587311, 13659.043866929418, 13781.724365512835, 13862.306884655727, 14042.789358159636, 329812.0, 335350.0, 335424.0, 336188.0, 336825.0, 48077.0, 48464.0, 48717.0, 48928.0, 48981.26528102082, 1203.3622180244483, 1224.1736827641307, 1256.7737807194792, 1257.911946163778, 1284.991281843748, 25180.49639007173, 26271.605925910746, 26352.0, 26703.599446008713, 26725.732742673103, 41071.7946410278, 41610.0, 41797.37303940504, 41824.79087604542, 41880.3717944225, 329880.0, 332056.0, 332666.0, 333321.0, 333521.0, 25015.0, 25588.0, 25986.87006564955, 26125.346866328495, 26144.60783088293, 40237.0, 40679.59320406758, 41341.37987930123, 41901.371479427224, 41993.16013679648, 35491.64508354987, 35720.464193036605, 35979.640203598676, 35986.64013359938, 36111.63888361188, 35037.649623503436, 35499.82250088733, 35662.64337356593, 35747.46378804372, 35909.0, 34003.0, 34526.654733453346, 34584.65415345814, 34662.13344666403, 35243.82378088093, 29808.552871707376, 31705.365892681555, 31812.204694881886, 31949.68050319467, 32149.839250803598, 24874.25377238686, 25043.624345634467, 25091.498170036863, 25176.622350664387, 25528.23415297544], "value": 16177.777901631402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9418840079788, 378.3190257536435, 380.9276237514872, 387.68403750942963, 391.4832421204012, 15411.306491207895, 15886.761698574515, 16866.915665421686, 16894.324227030906, 16908.915455422735, 10757.193210509224, 10813.405262710567, 10827.404492752896, 10848.457577121133, 10893.128549716024, 4595.862124136282, 4602.7008244464005, 4753.239481682931, 4783.784729687172, 4807.735574543399, 4650.8604741857625, 4700.694454860441, 4704.482506924235, 4713.340132381452, 4732.574068333849, 4535.863924082283, 4717.292406139072, 4731.172044892147, 4742.312364707115, 5169.966006798637, 5142.897142057175, 5153.175491921274, 5168.043911876296, 5180.45605211453, 5180.7150606716805, 4528.8867778305475, 4554.8861278467975, 4568.748718820463, 4612.192866248393, 4623.006053698437, 12306.26162430248, 12383.257004579755, 12390.876091239063, 12420.378981050912, 12451.252924824448, 1743.5379624399545, 1837.2283640870733, 1936.9225230990744, 2033.6949457581334, 2361.9645705314433, 9422.717318480456, 9452.621895124186, 9472.810543789155, 9610.615575376976, 9681.951590242074, 1692.5514738594281, 1747.0915124135506, 1763.0391436667048, 1769.0712376002573, 1776.316118294453, 65807.0, 68626.0, 70101.2989870105, 70666.0, 70729.2927070733, 10224.233182511342, 10284.177265818716, 10336.328138671113, 10503.159747220205, 10551.683449496528, 14172.220527871066, 14257.287135643177, 14264.42942282297, 14275.286235688174, 14276.500322488662, 6859.9314006860295, 7082.5396349237135, 7107.466939979522, 7179.497435179487, 7214.206437291894, 6489.837754056092, 6553.672316384162, 6607.141071660653, 6706.966465167643, 6724.260331363546, 4391.143726973273, 4397.538258482878, 4418.5802348776815, 4480.507144214133, 4545.068261006551, 1833.1659095111693, 1900.4963684623585, 1910.522369407648, 1917.5493758966632, 1940.689489681644, 814.3566582399956, 843.8649816029406, 846.327169899931, 868.700298397052, 976.8827740671165, 15671.764923526156, 15887.841121588635, 15898.18923132281, 16089.436869709738, 16332.101734404721, 837.6806529715722, 869.6912596028445, 901.1934318784782, 903.5437104262305, 916.812053529025, 8985.011648718635, 8988.235999940078, 9127.0, 9342.439453632804, 9358.204552613104, 405825.0, 413233.0, 414705.0, 416465.0, 418817.0, 59047.70476147592, 73938.0, 78227.21772782312, 79797.20202797897, 80034.59982700166, 886.2732559301311, 892.2237653241722, 902.1069141549949, 905.0677801864091, 909.9181073703398, 14905.329260183535, 14917.47788827386, 14921.850781492047, 15097.320620571882, 15803.130827804582, 24554.631680525163, 25622.871885640452, 35616.82191589026, 36779.81610091932, 37461.250774983804, 41663.7916810414, 44445.11109777851, 45168.09663806771, 46178.53821461877, 51830.48169518256, 10165.339252948535, 11025.724356891142, 11227.607033753779, 11563.768724625628, 11625.825612615648, 12593.0, 12672.746545068863, 12675.619731408073, 12915.22508649484, 13007.674808129872, 6010.849728756816, 9549.90450095518, 10763.838542421714, 10982.835257471304, 11009.174311926477, 10908.836367454653, 11024.44877756125, 11064.225504214628, 11115.610953616584, 11403.372814495282, 10250.794984100425, 10538.833593156727, 11077.058450031838, 11163.330200188015, 11424.371659558472, 11522.711932201762, 11544.942275288906, 11619.477123529292, 11703.0, 11816.231944923553, 10929.836052459379, 10983.61557345521, 11082.390468524309, 11118.110551156049, 11211.159163062639], "value": 8057.393990140155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.9928200359, 1448.2396741710604, 1603.3025633849277, 1724.741288806678, 1752.2377765671943, 6993.720251189946, 7394.223606521318, 7575.810604734885, 7886.487378320412, 7894.052713674353, 7650.693972241118, 7651.617419129049, 7673.808154796133, 7691.077070751504, 7772.378209743221, 2266.002958698172, 2299.1608063057033, 2306.0199415248535, 2309.9191528296515, 2322.222055611372, 2271.716035495563, 2273.6816845641624, 2308.8614683119067, 2309.307207837642, 2318.0, 2295.82781291403, 2312.8496647717843, 2323.105604342332, 2351.7295511016196, 2356.387339291788, 2230.096810791632, 2260.8078313343385, 2261.2198791417018, 2262.3552287597954, 2262.4343914021497, 2218.9778102218934, 2276.237460450751, 2278.0, 2279.920202792911, 2283.6346184610384, 7718.614069296513, 7813.882791758128, 7840.529568225925, 7845.882311765328, 7856.017997750281, 4675.485696573374, 4745.16959532084, 4768.237082066853, 4789.856304310876, 4791.185498465269, 2823.265950852793, 2920.255334889611, 2999.145243605584, 3010.834404107773, 3038.3923215356795, 1022.5551884930079, 1022.8721409823772, 1022.8977102289786, 1028.83024300991, 1028.876534815827, 10608.09831164352, 10612.41631710248, 10642.946785266024, 10672.359658420519, 10692.144628429707, 4258.68059895509, 4360.542143074995, 4516.503184649686, 4535.841245556389, 4641.976790116028, 9084.682036128705, 9096.998660294725, 9112.544372781334, 9141.497217653094, 9199.540022998823, 4790.520947905251, 4792.0, 4817.807287708522, 4839.274108883696, 4849.854504364875, 3766.9058273542832, 4078.490188726409, 4251.128518653669, 4365.301551751704, 4390.473143222834, 3722.7021838252876, 3786.9431958520645, 3813.7033408641196, 3820.1213720843807, 3854.614538546179, 1247.4760600547793, 1266.2143284773535, 1267.1763353819906, 1268.6257554021586, 1275.4515558309831, 775.806048487878, 775.8138046868711, 792.3106896999648, 794.527256282511, 804.766617680866, 5089.262057001714, 5270.683758974474, 5296.841094767163, 5313.840584782462, 5376.327959005124, 423.45585922089964, 432.48966219860864, 435.44698233243605, 440.67830483746405, 442.31441266038155, 3574.857005719742, 3613.403788374941, 3687.94468082979, 3692.9076773080888, 3711.4432835074413, 9285.48929808867, 9607.327487075978, 9631.951840240754, 9658.75853103664, 9733.2213422926, 9011.414258073204, 9338.95330523343, 9476.384035037701, 9519.714408567754, 9567.521623918776, 7034.859302813813, 7152.821179470555, 7337.41300695943, 7341.229170937081, 7380.372668323145, 5248.685078895279, 5381.381141168816, 5387.0572649785345, 5387.599224201657, 5395.946040539544, 8927.464352138892, 8953.641854326015, 9095.408798428081, 9123.315751318545, 9253.398529095588, 8755.781105472413, 8965.596548155218, 9052.547372631474, 9198.67804626835, 9247.861282080908, 6142.78500252489, 6526.151600291932, 6679.899801503078, 6795.354441328066, 6874.415674667709, 7292.088488938883, 7332.963335183504, 7336.889946650911, 7398.630068496446, 7410.740624078347, 6557.442617377576, 6700.597964122168, 6711.597304161571, 6744.898826517508, 6758.526903116931, 6581.111549940697, 6595.868082638224, 6642.5018123641885, 6645.0, 6683.398494135551, 6128.9693551531955, 6136.355682653436, 6183.474404675473, 6192.907106393498, 6199.318075011655, 4352.064306174188, 4427.070315233837, 4445.222086134849, 4510.120526497432, 4529.7282163069, 4412.492563355255, 4423.203823311835, 4440.311751678495, 4457.68796184264, 4474.664400169935], "value": 4120.245153266626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.47149260734574, 319.83048984038453, 321.82943040188707, 324.1862924060607, 324.8521922525251, 5411.0, 5473.288472498574, 5485.396606373306, 5486.91769623456, 5510.256115424417, 5376.51611354978, 5387.676739395639, 5396.384422436967, 5418.187271909215, 5421.376541697706, 3945.132070944395, 4014.257362387953, 4139.751614903101, 4160.313548264533, 4168.958310416887, 4185.707000509966, 4192.203481338536, 4192.392103145042, 4195.7063005589625, 4197.265478541259, 4160.1471698301775, 4162.43807086044, 4168.583141685837, 4170.22850772608, 4172.499300083994, 4078.388241763744, 4139.648129908961, 4154.273002224599, 4169.185799585298, 4173.603507666767, 3595.82020898954, 3610.9277814443826, 3621.3481573316794, 3629.8185090745355, 3649.069487280753, 5055.9241611375855, 5104.438511763703, 5113.974430127862, 5139.61452891031, 5180.481951804827, 4493.146302202571, 4736.881577960544, 4753.168195565762, 4771.355866957951, 4798.616110711169, 5677.7289084366175, 5678.119891416837, 5678.545716342724, 5680.11958146488, 5693.202951586781, 3897.5907529709257, 3936.881893543198, 3939.4484772131923, 3943.743656662308, 3950.1902110067367, 5865.970670146665, 5979.1629171915965, 5993.374008724702, 6038.0, 6043.093535969596, 3989.5810939851476, 4005.2990726622725, 4010.5588385277597, 4024.6176613222283, 4042.6361627453084, 4067.0, 4073.103917138225, 4090.7545547266664, 4093.079057212163, 4104.501856822298, 4578.0, 4714.528547145258, 4722.95277047232, 4743.644226682944, 4752.1683705351425, 5711.857203569944, 5719.571032172604, 5720.742566584514, 5730.226419433407, 5754.367019627837, 1396.7276381105587, 1406.374163497234, 1409.9083559568596, 1412.8092707484564, 1416.3130881522454, 864.1185990289869, 921.4655499810228, 940.7365937537501, 966.2801213096288, 966.9371490853072, 4822.590079843252, 4873.731944743002, 4874.122657921608, 4875.902481950341, 4904.485029071968, 5831.154482599999, 5864.296284445893, 5872.207252020922, 5874.03078492044, 5937.812437512514, 4708.788104535304, 4870.342503762017, 4888.0, 4924.35983322173, 4943.653944223942, 3153.952690709641, 3224.1783392383227, 3227.370662720794, 3232.369687910882, 3235.5955505561806, 5574.442555744393, 5582.944170558242, 5584.636998595079, 5586.636868603528, 5589.972050139723, 5886.646801191942, 6135.693215339215, 6137.631742095488, 6152.031349967967, 6169.2288463942, 5527.917081243865, 5553.278073850373, 5563.888722225533, 5589.133684278943, 5590.972045139748, 5670.144301874765, 5955.0, 5958.374370691015, 5970.880582388415, 6040.6677632730625, 5876.1773351729935, 5894.646321220741, 5900.881982360243, 5919.200907877382, 5921.3190483094995, 5568.415316391883, 5594.860128496657, 5601.41185175567, 5603.327600687943, 5611.0, 3887.125396785814, 4075.4498142751536, 4100.692448066347, 4102.405151253111, 4117.197146556393, 5949.52403807703, 5967.134765459071, 5983.431574000463, 5995.190649262294, 6013.872786151264, 5598.804041858678, 5737.168110624019, 5744.109663002241, 5787.56593255516, 5796.1305804129715, 5722.6852523109965, 5780.410387143401, 5815.680137592473, 5819.127130930395, 5823.155642431909, 5354.678719276856, 5701.914471283017, 5708.714564271687, 5716.342620598684, 5718.1708652246025, 5643.943560564506, 5826.912596310974, 5829.679367634821, 5840.240768700041, 5874.265716785402, 5662.320521537442, 5668.149777533238, 5669.829905102853, 5674.0, 5686.800961966312], "value": 4264.4664035989435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3778077735092, 624.6658037949697, 709.1915216653014, 735.1215297719224, 748.3601520699801, 11772.882271177286, 11830.0, 12286.262824230542, 12395.318257495834, 12977.740445191113, 12680.936595317033, 12683.61949141525, 12793.872061279384, 12836.0372972027, 12843.35783210838, 618.1222663817367, 762.9351505122044, 781.3319611731959, 792.9484583502054, 797.7686470923426, 788.5505262000662, 792.6195426195429, 794.6900708723603, 800.747764454198, 800.9839803203932, 819.2954059508818, 824.085265355455, 826.983460330793, 828.2752591482453, 829.9751007469755, 821.1008945204991, 821.3962737388015, 830.0827585517976, 830.8006078541137, 831.6756464978663, 607.3683369295927, 607.6566739792004, 608.656109298245, 608.7108623403892, 610.3560743415694, 12392.504299827997, 12405.0, 12498.562550310695, 12508.061895357885, 12556.121071524996, 12567.622971310875, 12576.11967162299, 12582.496700131984, 12884.226946383247, 13034.087613867034, 9952.104310612007, 10059.195264378905, 10142.239332050052, 10378.896211037943, 10573.894261057369, 3358.7648864579487, 3377.8986630401128, 3390.542276792626, 3397.13373089863, 3474.7567670263093, 49885.25172122421, 50062.49937500651, 50409.47133700643, 50685.74657126691, 50808.0, 9234.81530369389, 9386.0, 9404.764880877896, 9470.768800056087, 9534.189593884597, 16953.541736448147, 17069.0, 17091.059991700327, 17104.230309636096, 17146.828531714524, 6943.652817359111, 7008.614526201108, 7035.7185712571945, 7105.538140020882, 7113.502054856214, 3654.4518322251342, 3806.0865392305645, 3855.4602355670227, 3869.9806500967316, 3896.7077469189926, 2864.7278508541654, 2872.971270287312, 2888.1479963410843, 2894.9276268093045, 2898.2899189698237, 488.67747286790546, 506.6250974279081, 510.6859281541825, 514.0, 520.7188118416013, 573.8708790522182, 586.7711592478937, 606.6481440764346, 612.5467154305782, 614.4562062574654, 7312.378447831994, 7407.85184296311, 7413.555186688816, 7431.368333691588, 7752.961235193788, 466.93696350992184, 488.5261296542348, 489.47626040136714, 493.4843088972033, 506.9949300506948, 2885.1488810800865, 2921.1382642120625, 2923.8391888445913, 2931.0620601407345, 2962.8074175178544, 42004.0, 48947.510524895006, 49246.50753492419, 53776.73111634417, 54542.727286364105, 40049.39925901114, 40527.1894562113, 40742.9814254646, 41055.178896422505, 42650.78674606669, 40323.395149072785, 41017.384739228335, 41289.38065929014, 41356.0, 42465.36301955473, 7096.503244772816, 7377.1885092638695, 7426.888596670946, 7495.43784216175, 7595.5442673439775, 28323.858380707963, 29344.41311173807, 29764.85117574398, 29824.850875745484, 30095.849520752257, 37203.255934881694, 39061.0, 39746.80126599464, 39997.40003900002, 40083.799581001906, 9892.109710126124, 9937.304388693012, 10039.949800250952, 10155.54300056514, 10320.896791031993, 10717.14262858985, 10790.406527640742, 10951.945240273748, 11098.0, 11113.110951124052, 9006.59470323824, 9211.723648290563, 9312.627494900398, 9403.717888463358, 9591.328606997444, 9771.609135634779, 9851.261155413229, 9880.752981175528, 9991.650292239738, 10160.745981350525, 10115.342502737298, 10135.79728405413, 10142.29003969715, 10206.897931020594, 10229.48852557384, 8210.83578328442, 8522.914770852212, 8568.400211985101, 8591.957040214758, 9053.049429809775, 8407.411481196257, 8456.492610443393, 8694.391392602458, 8782.516961567175, 8804.295656347605], "value": 5702.797109611071, "unit": "score"}], "name": "dromaeo_css", "value": 6285.877009809057, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 113.0, 113.0, 126.0, 112.0, 113.0, 112.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 136.0, 161.0, 181.0, 139.0, 158.0, 162.0, 143.0, 204.0, 133.0], "value": 157.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 164.0, 169.0, 166.0, 164.0, 163.0, 166.0, 165.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 155.0, 74.0, 76.0, 77.0, 73.0, 163.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 138.0, 94.0, 94.0, 93.0, 135.0, 94.0, 94.0, 144.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 69.0, 67.0, 71.0, 83.0, 63.0, 63.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 63.0, 68.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 79.0, 83.0, 82.0, 81.0, 80.0, 80.0, 81.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 135.0, 149.0, 137.0, 135.0, 133.0, 138.0, 138.0, 174.0, 142.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 176.0, 184.0, 181.0, 180.0, 184.0, 178.0, 173.0, 180.0, 186.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 74.0, 74.0, 74.0, 71.0, 72.0, 72.0, 72.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1607.3999999999999, "alertThreshold": 2.0}]} 05:43:49 INFO - Return code: 0 05:43:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:43:49 ERROR - # TBPL SUCCESS # 05:43:49 INFO - Running post-action listener: _resource_record_post_action 05:43:49 INFO - Running post-run listener: _resource_record_post_run 05:43:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518225920; Read time: 12; Write time: 413584 05:43:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234590208; Read time: 0; Write time: 202368 05:43:50 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283635712; Read time: 12; Write time: 211216 05:43:50 INFO - Running post-run listener: _upload_blobber_files 05:43:50 INFO - Blob upload gear active. 05:43:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:51 INFO - (blobuploader) - INFO - Done attempting. 05:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:52 INFO - (blobuploader) - INFO - Done attempting. 05:43:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:52 INFO - Return code: 0 05:43:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec7587cb07947291309f8c9217657cd176afa42843d16602ba2ed6a3090dd1aa3b65e51011ea4d76ac7677de1f36bf9b0352eceb841dc292566859aedab2464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be5746adab2f351e3e239ff48745b42572ac44df9d047b41b67e3a6ecb98c978fb09566f76cef84cd89c6fa170ca3fd765e5d5d67153d2534560301093b125c8"} 05:43:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:52 INFO - Contents: 05:43:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec7587cb07947291309f8c9217657cd176afa42843d16602ba2ed6a3090dd1aa3b65e51011ea4d76ac7677de1f36bf9b0352eceb841dc292566859aedab2464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be5746adab2f351e3e239ff48745b42572ac44df9d047b41b67e3a6ecb98c978fb09566f76cef84cd89c6fa170ca3fd765e5d5d67153d2534560301093b125c8"} 05:43:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:52 INFO - Copying logs to upload dir... 05:43:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.182204 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 05:43:52.321456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:43:52.325338) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec7587cb07947291309f8c9217657cd176afa42843d16602ba2ed6a3090dd1aa3b65e51011ea4d76ac7677de1f36bf9b0352eceb841dc292566859aedab2464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be5746adab2f351e3e239ff48745b42572ac44df9d047b41b67e3a6ecb98c978fb09566f76cef84cd89c6fa170ca3fd765e5d5d67153d2534560301093b125c8"} build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec7587cb07947291309f8c9217657cd176afa42843d16602ba2ed6a3090dd1aa3b65e51011ea4d76ac7677de1f36bf9b0352eceb841dc292566859aedab2464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be5746adab2f351e3e239ff48745b42572ac44df9d047b41b67e3a6ecb98c978fb09566f76cef84cd89c6fa170ca3fd765e5d5d67153d2534560301093b125c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:43:52.349238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:43:52.349515) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461586996.207044-1575334164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:43:52.431514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:43:52.431797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:43:52.432066) ========= ========= Total master_lag: 0.16 =========