builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1461216135.48 results: success (0) buildid: 20160420210806 builduid: 50b3629257d7438cae535c69ac15a39a revision: 85616706a29b8944f3a09f5cc32e9e219f6ceb40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.484442) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.484967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.485289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.531831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.532185) ========= 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=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 22:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.8M=0s 2016-04-20 22:22:15 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.239892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.793734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.794094) ========= 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=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013342 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:15.844212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 22:22:15.844602) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 85616706a29b8944f3a09f5cc32e9e219f6ceb40 --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 85616706a29b8944f3a09f5cc32e9e219f6ceb40 --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=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 22:22:15,939 truncating revision to first 12 chars 2016-04-20 22:22:15,939 Setting DEBUG logging. 2016-04-20 22:22:15,939 attempt 1/10 2016-04-20 22:22:15,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/85616706a29b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 22:22:16,809 unpacking tar archive at: fx-team-85616706a29b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 22:22:17.038718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:17.039087) ========= script_repo_revision: 85616706a29b8944f3a09f5cc32e9e219f6ceb40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:17.039536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:17.039823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:22:17.050378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-20 22:22:17.051177) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:17 INFO - MultiFileLogger online at 20160420 22:22:17 in /builds/slave/test 22:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:17 INFO - {'append_to_log': False, 22:22:17 INFO - 'base_work_dir': '/builds/slave/test', 22:22:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:17 INFO - 'branch': 'Fx-Team-Non-PGO', 22:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:17 INFO - 'config_files': ('talos/linux_config.py',), 22:22:17 INFO - 'default_actions': ('clobber', 22:22:17 INFO - 'read-buildbot-config', 22:22:17 INFO - 'download-and-extract', 22:22:17 INFO - 'populate-webroot', 22:22:17 INFO - 'create-virtualenv', 22:22:17 INFO - 'install', 22:22:17 INFO - 'run-tests'), 22:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:17 INFO - 'download_minidump_stackwalk': True, 22:22:17 INFO - 'download_symbols': 'ondemand', 22:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:17 INFO - 'installer_path': 'installer.exe', 22:22:17 INFO - 'log_level': 'info', 22:22:17 INFO - 'log_name': 'talos', 22:22:17 INFO - 'log_to_console': True, 22:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:17 INFO - 'opt_config_files': (), 22:22:17 INFO - 'pip_index': False, 22:22:17 INFO - 'sps_profile': False, 22:22:17 INFO - 'sps_profile_interval': 0, 22:22:17 INFO - 'suite': 'dromaeojs', 22:22:17 INFO - 'system_bits': '32', 22:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:17 INFO - 'title': 'talos-linux64-ix-045', 22:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:17 INFO - 'use_talos_json': True, 22:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:17 INFO - 'work_dir': 'build'} 22:22:17 INFO - ##### 22:22:17 INFO - ##### Running clobber step. 22:22:17 INFO - ##### 22:22:17 INFO - Running pre-action listener: _resource_record_pre_action 22:22:17 INFO - Running main action method: clobber 22:22:17 INFO - rmtree: /builds/slave/test/build 22:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:18 INFO - Running post-action listener: _resource_record_post_action 22:22:18 INFO - ##### 22:22:18 INFO - ##### Running read-buildbot-config step. 22:22:18 INFO - ##### 22:22:18 INFO - Running pre-action listener: _resource_record_pre_action 22:22:18 INFO - Running main action method: read_buildbot_config 22:22:18 INFO - Using buildbot properties: 22:22:18 INFO - { 22:22:18 INFO - "project": "", 22:22:18 INFO - "product": "firefox", 22:22:18 INFO - "script_repo_revision": "production", 22:22:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:22:18 INFO - "repository": "", 22:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:22:18 INFO - "buildid": "20160420210806", 22:22:18 INFO - "pgo_build": "False", 22:22:18 INFO - "basedir": "/builds/slave/test", 22:22:18 INFO - "buildnumber": 2853, 22:22:18 INFO - "slavename": "talos-linux64-ix-045", 22:22:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:22:18 INFO - "platform": "ubuntu64_hw", 22:22:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:22:18 INFO - "branch": "fx-team", 22:22:18 INFO - "repo_path": "integration/fx-team", 22:22:18 INFO - "revision": "85616706a29b8944f3a09f5cc32e9e219f6ceb40", 22:22:18 INFO - "stage_platform": "linux64", 22:22:18 INFO - "builduid": "50b3629257d7438cae535c69ac15a39a", 22:22:18 INFO - "slavebuilddir": "test" 22:22:18 INFO - } 22:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:22:18 INFO - Running post-action listener: _resource_record_post_action 22:22:18 INFO - ##### 22:22:18 INFO - ##### Running download-and-extract step. 22:22:18 INFO - ##### 22:22:18 INFO - Running pre-action listener: _resource_record_pre_action 22:22:18 INFO - Running main action method: download_and_extract 22:22:18 INFO - mkdir: /builds/slave/test/build/tests 22:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:18 INFO - https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:20 INFO - Downloaded 1361 bytes. 22:22:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:22:20 INFO - Using the following test package requirements: 22:22:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:22:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'jsshell-linux-x86_64.zip'], 22:22:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:22:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:22:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22: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')]} 22:22:20 INFO - https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:39 INFO - Downloaded 22275480 bytes. 22:22:39 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'] 22:22:39 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 22:22:40 INFO - Return code: 0 22:22:40 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 22:22:40 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')]} 22:22:40 INFO - https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:43 INFO - Downloaded 22275480 bytes. 22:22:43 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'] 22:22:43 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 22:22:45 INFO - Return code: 0 22:22:45 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')]} 22:22:45 INFO - https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:46 INFO - Downloaded 10845952 bytes. 22:22:46 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'] 22:22:46 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 22:22:46 INFO - Return code: 0 22:22: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')]} 22:22:46 INFO - https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fy8GDjf-QLaClx6oG9xtxg/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 22:22:55 INFO - Downloaded 54660518 bytes. 22:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:22:55 INFO - mkdir: /builds/slave/test/properties 22:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:55 INFO - Contents: 22:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:22:56 INFO - Running post-action listener: _resource_record_post_action 22:22:56 INFO - Running post-action listener: set_extra_try_arguments 22:22:56 INFO - ##### 22:22:56 INFO - ##### Running populate-webroot step. 22:22:56 INFO - ##### 22:22:56 INFO - Running pre-action listener: _resource_record_pre_action 22:22:56 INFO - Running main action method: populate_webroot 22:22:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:56 INFO - '--tppagecycles', 22:22:56 INFO - '7'], 22:22:56 INFO - 'tests': ['tsvgm']}}, 22:22:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:22:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:22:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['damp', 'tps']}, 22:22:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['damp', 'tps']}, 22:22:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['dromaeo_dom']}, 22:22:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['tsvgx', 22:22:56 INFO - 'tsvgr_opacity', 22:22:56 INFO - 'tart', 22:22:56 INFO - 'tscrollx', 22:22:56 INFO - 'cart']}, 22:22:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:22:56 INFO - 'tsvgr_opacity', 22:22:56 INFO - 'tart', 22:22:56 INFO - 'tscrollx', 22:22:56 INFO - 'cart']}, 22:22:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--disable-e10s'], 22:22:56 INFO - 'tests': ['tp5o']}, 22:22:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['tp5o']}, 22:22:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--disable-e10s', 22:22:56 INFO - '--xperf_path', 22:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:56 INFO - 'tests': ['tp5n']}, 22:22:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--xperf_path', 22:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:56 INFO - 'tests': ['tp5n']}}, 22:22:56 INFO - 'talos.zip': {'path': '', 22:22:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:56 INFO - Running post-action listener: _resource_record_post_action 22:22:56 INFO - ##### 22:22:56 INFO - ##### Running create-virtualenv step. 22:22:56 INFO - ##### 22:22:56 INFO - Running pre-action listener: _resource_record_pre_action 22:22:56 INFO - Running main action method: create_virtualenv 22:22:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:56 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 22:22:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:56 INFO - Using real prefix '/usr' 22:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:59 INFO - Installing pip.................done. 22:22:59 INFO - Return code: 0 22:22:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:59 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')]} 22:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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')]} 22:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:22:59 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 22:22:59 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 22:22:59 INFO - Using env: {'DISPLAY': ':0', 22:22:59 INFO - 'HOME': '/home/cltbld', 22:22:59 INFO - 'LANG': 'en_US.UTF-8', 22:22:59 INFO - 'LANGUAGE': 'en_US:en', 22:22:59 INFO - 'LOGNAME': 'cltbld', 22:22:59 INFO - 'MAIL': '/var/mail/cltbld', 22:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:59 INFO - 'MOZ_NO_REMOTE': '1', 22:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:59 INFO - 'NO_EM_RESTART': '1', 22:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:59 INFO - 'PWD': '/builds/slave/test', 22:22:59 INFO - 'SHELL': '/bin/bash', 22:22:59 INFO - 'SHLVL': '1', 22:22:59 INFO - 'TERM': 'linux', 22:22:59 INFO - 'TMOUT': '86400', 22:22:59 INFO - 'USER': 'cltbld', 22:22:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:59 INFO - '_': '/tools/buildbot/bin/python'} 22:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:59 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 22:22:59 INFO - Cleaning up... 22:22:59 INFO - Return code: 0 22:22:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:22:59 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')]} 22:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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')]} 22:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:22:59 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 22:22:59 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 22:22:59 INFO - Using env: {'DISPLAY': ':0', 22:22:59 INFO - 'HOME': '/home/cltbld', 22:22:59 INFO - 'LANG': 'en_US.UTF-8', 22:22:59 INFO - 'LANGUAGE': 'en_US:en', 22:22:59 INFO - 'LOGNAME': 'cltbld', 22:22:59 INFO - 'MAIL': '/var/mail/cltbld', 22:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:59 INFO - 'MOZ_NO_REMOTE': '1', 22:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:59 INFO - 'NO_EM_RESTART': '1', 22:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:59 INFO - 'PWD': '/builds/slave/test', 22:22:59 INFO - 'SHELL': '/bin/bash', 22:22:59 INFO - 'SHLVL': '1', 22:22:59 INFO - 'TERM': 'linux', 22:22:59 INFO - 'TMOUT': '86400', 22:22:59 INFO - 'USER': 'cltbld', 22:22:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:59 INFO - '_': '/tools/buildbot/bin/python'} 22:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:59 INFO - Downloading/unpacking psutil>=0.7.1 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:23:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:01 INFO - Installing collected packages: psutil 22:23:01 INFO - Running setup.py install for psutil 22:23:01 INFO - building 'psutil._psutil_linux' extension 22:23:01 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 22:23:02 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 22:23:02 INFO - building 'psutil._psutil_posix' extension 22:23:02 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 22:23:02 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 22:23:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:02 INFO - Successfully installed psutil 22:23:02 INFO - Cleaning up... 22:23:02 INFO - Return code: 0 22:23:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:02 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:02 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 22:23:02 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 22:23:02 INFO - Using env: {'DISPLAY': ':0', 22:23:02 INFO - 'HOME': '/home/cltbld', 22:23:02 INFO - 'LANG': 'en_US.UTF-8', 22:23:02 INFO - 'LANGUAGE': 'en_US:en', 22:23:02 INFO - 'LOGNAME': 'cltbld', 22:23:02 INFO - 'MAIL': '/var/mail/cltbld', 22:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:02 INFO - 'MOZ_NO_REMOTE': '1', 22:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:02 INFO - 'NO_EM_RESTART': '1', 22:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:02 INFO - 'PWD': '/builds/slave/test', 22:23:02 INFO - 'SHELL': '/bin/bash', 22:23:02 INFO - 'SHLVL': '1', 22:23:02 INFO - 'TERM': 'linux', 22:23:02 INFO - 'TMOUT': '86400', 22:23:02 INFO - 'USER': 'cltbld', 22:23:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:02 INFO - '_': '/tools/buildbot/bin/python'} 22:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:23:05 INFO - Installing collected packages: mozsystemmonitor 22:23:05 INFO - Running setup.py install for mozsystemmonitor 22:23:05 INFO - Successfully installed mozsystemmonitor 22:23:05 INFO - Cleaning up... 22:23:05 INFO - Return code: 0 22:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:23:05 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')]} 22:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:05 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')]} 22:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:05 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:05 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 22:23:05 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 22:23:05 INFO - Using env: {'DISPLAY': ':0', 22:23:05 INFO - 'HOME': '/home/cltbld', 22:23:05 INFO - 'LANG': 'en_US.UTF-8', 22:23:05 INFO - 'LANGUAGE': 'en_US:en', 22:23:05 INFO - 'LOGNAME': 'cltbld', 22:23:05 INFO - 'MAIL': '/var/mail/cltbld', 22:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:05 INFO - 'MOZ_NO_REMOTE': '1', 22:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:05 INFO - 'NO_EM_RESTART': '1', 22:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:05 INFO - 'PWD': '/builds/slave/test', 22:23:05 INFO - 'SHELL': '/bin/bash', 22:23:05 INFO - 'SHLVL': '1', 22:23:05 INFO - 'TERM': 'linux', 22:23:05 INFO - 'TMOUT': '86400', 22:23:05 INFO - 'USER': 'cltbld', 22:23:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:05 INFO - '_': '/tools/buildbot/bin/python'} 22:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 22:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:07 INFO - Downloading blobuploader-1.2.4.tar.gz 22:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:23:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:23:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:07 INFO - Downloading docopt-0.6.1.tar.gz 22:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:23:08 INFO - Installing collected packages: blobuploader, requests, docopt 22:23:08 INFO - Running setup.py install for blobuploader 22:23:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:23:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:23:08 INFO - Running setup.py install for requests 22:23:08 INFO - Running setup.py install for docopt 22:23:08 INFO - Successfully installed blobuploader requests docopt 22:23:08 INFO - Cleaning up... 22:23:08 INFO - Return code: 0 22:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23: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')]} 22:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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')]} 22:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:08 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:08 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 22:23:08 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 22:23:08 INFO - Using env: {'DISPLAY': ':0', 22:23:08 INFO - 'HOME': '/home/cltbld', 22:23:08 INFO - 'LANG': 'en_US.UTF-8', 22:23:08 INFO - 'LANGUAGE': 'en_US:en', 22:23:08 INFO - 'LOGNAME': 'cltbld', 22:23:08 INFO - 'MAIL': '/var/mail/cltbld', 22:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:08 INFO - 'MOZ_NO_REMOTE': '1', 22:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:08 INFO - 'NO_EM_RESTART': '1', 22:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:08 INFO - 'PWD': '/builds/slave/test', 22:23:08 INFO - 'SHELL': '/bin/bash', 22:23:08 INFO - 'SHLVL': '1', 22:23:08 INFO - 'TERM': 'linux', 22:23:08 INFO - 'TMOUT': '86400', 22:23:08 INFO - 'USER': 'cltbld', 22:23:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:08 INFO - '_': '/tools/buildbot/bin/python'} 22:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:08 INFO - Running setup.py (path:/tmp/pip-t6fHuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:08 INFO - Running setup.py (path:/tmp/pip-WUxsWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:08 INFO - Running setup.py (path:/tmp/pip-0VoPEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:09 INFO - Running setup.py (path:/tmp/pip-BQsGP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:09 INFO - Running setup.py (path:/tmp/pip-88D4Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:09 INFO - Running setup.py (path:/tmp/pip-FkJcRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:09 INFO - Running setup.py (path:/tmp/pip-ltKAWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:09 INFO - Running setup.py (path:/tmp/pip-R0XvVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:09 INFO - Running setup.py (path:/tmp/pip-RlRu4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:09 INFO - Running setup.py (path:/tmp/pip-FS7chO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:09 INFO - Running setup.py (path:/tmp/pip-lpr2ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:09 INFO - Running setup.py (path:/tmp/pip-yV2DS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:09 INFO - Running setup.py (path:/tmp/pip-Hhk1vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:09 INFO - Running setup.py (path:/tmp/pip-sYPtk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:09 INFO - Running setup.py (path:/tmp/pip-b0npAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:09 INFO - Running setup.py (path:/tmp/pip-HTzTz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:09 INFO - Running setup.py (path:/tmp/pip-_GTex5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:23:10 INFO - Running setup.py install for manifestparser 22:23:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozcrash 22:23:10 INFO - Running setup.py install for mozdebug 22:23:10 INFO - Running setup.py install for mozdevice 22:23:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozfile 22:23:10 INFO - Running setup.py install for mozhttpd 22:23:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozinfo 22:23:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozInstall 22:23:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozleak 22:23:10 INFO - Running setup.py install for mozlog 22:23:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Running setup.py install for moznetwork 22:23:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Running setup.py install for mozprocess 22:23:11 INFO - Running setup.py install for mozprofile 22:23:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Running setup.py install for mozrunner 22:23:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Running setup.py install for mozscreenshot 22:23:11 INFO - Running setup.py install for moztest 22:23:11 INFO - Running setup.py install for mozversion 22:23:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:23:11 INFO - Cleaning up... 22:23:11 INFO - Return code: 0 22:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:11 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')]} 22:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:11 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')]} 22:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:11 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:11 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 22:23:11 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 22:23:11 INFO - Using env: {'DISPLAY': ':0', 22:23:11 INFO - 'HOME': '/home/cltbld', 22:23:11 INFO - 'LANG': 'en_US.UTF-8', 22:23:11 INFO - 'LANGUAGE': 'en_US:en', 22:23:11 INFO - 'LOGNAME': 'cltbld', 22:23:11 INFO - 'MAIL': '/var/mail/cltbld', 22:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:11 INFO - 'MOZ_NO_REMOTE': '1', 22:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:11 INFO - 'NO_EM_RESTART': '1', 22:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:11 INFO - 'PWD': '/builds/slave/test', 22:23:11 INFO - 'SHELL': '/bin/bash', 22:23:11 INFO - 'SHLVL': '1', 22:23:11 INFO - 'TERM': 'linux', 22:23:11 INFO - 'TMOUT': '86400', 22:23:11 INFO - 'USER': 'cltbld', 22:23:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:11 INFO - '_': '/tools/buildbot/bin/python'} 22:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:12 INFO - Running setup.py (path:/tmp/pip-geEkpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:12 INFO - Running setup.py (path:/tmp/pip-abh6ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:12 INFO - Running setup.py (path:/tmp/pip-RTg378-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:12 INFO - Running setup.py (path:/tmp/pip-GBxOrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:12 INFO - Running setup.py (path:/tmp/pip-xJW_qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:12 INFO - Running setup.py (path:/tmp/pip-TISwH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:12 INFO - Running setup.py (path:/tmp/pip-lmfw7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:12 INFO - Running setup.py (path:/tmp/pip-Jbkjvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:12 INFO - Running setup.py (path:/tmp/pip-P0Asa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:12 INFO - Running setup.py (path:/tmp/pip-lU7nsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:12 INFO - Running setup.py (path:/tmp/pip-4EFlS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:12 INFO - Running setup.py (path:/tmp/pip-xmZvCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:12 INFO - Running setup.py (path:/tmp/pip-ltIOs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:13 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)) 22:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:13 INFO - Running setup.py (path:/tmp/pip-f8D26J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:13 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)) 22:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:13 INFO - Running setup.py (path:/tmp/pip-PJwwm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:13 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)) 22:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:13 INFO - Running setup.py (path:/tmp/pip-nKqvru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:13 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)) 22:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:13 INFO - Running setup.py (path:/tmp/pip-QvcFLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:13 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)) 22:23:13 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)) 22:23:13 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)) 22:23:13 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)) 22:23:13 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)) 22:23:13 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)) 22:23:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:23:13 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 22:23:13 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 22:23:13 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 22:23:13 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 22:23:13 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 22:23:13 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 22:23:15 INFO - Downloading blessings-1.6.tar.gz 22:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:23:15 INFO - Installing collected packages: blessings 22:23:15 INFO - Running setup.py install for blessings 22:23:15 INFO - Successfully installed blessings 22:23:15 INFO - Cleaning up... 22:23:15 INFO - Return code: 0 22:23:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:15 INFO - Reading from file tmpfile_stdout 22:23:15 INFO - Current package versions: 22:23:15 INFO - argparse == 1.2.1 22:23:15 INFO - blessings == 1.6 22:23:15 INFO - blobuploader == 1.2.4 22:23:15 INFO - docopt == 0.6.1 22:23:15 INFO - manifestparser == 1.1 22:23:15 INFO - mozInstall == 1.12 22:23:15 INFO - mozcrash == 0.17 22:23:15 INFO - mozdebug == 0.1 22:23:15 INFO - mozdevice == 0.48 22:23:15 INFO - mozfile == 1.2 22:23:15 INFO - mozhttpd == 0.7 22:23:15 INFO - mozinfo == 0.9 22:23:15 INFO - mozleak == 0.1 22:23:15 INFO - mozlog == 3.1 22:23:15 INFO - moznetwork == 0.27 22:23:15 INFO - mozprocess == 0.22 22:23:15 INFO - mozprofile == 0.28 22:23:15 INFO - mozrunner == 6.11 22:23:15 INFO - mozscreenshot == 0.1 22:23:15 INFO - mozsystemmonitor == 0.0 22:23:15 INFO - moztest == 0.7 22:23:15 INFO - mozversion == 1.4 22:23:15 INFO - psutil == 3.1.1 22:23:15 INFO - requests == 1.2.3 22:23:15 INFO - wsgiref == 0.1.2 22:23:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:15 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 22:23:15 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 22:23:15 INFO - Using env: {'DISPLAY': ':0', 22:23:15 INFO - 'HOME': '/home/cltbld', 22:23:15 INFO - 'LANG': 'en_US.UTF-8', 22:23:15 INFO - 'LANGUAGE': 'en_US:en', 22:23:15 INFO - 'LOGNAME': 'cltbld', 22:23:15 INFO - 'MAIL': '/var/mail/cltbld', 22:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:15 INFO - 'MOZ_NO_REMOTE': '1', 22:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:15 INFO - 'NO_EM_RESTART': '1', 22:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:15 INFO - 'PWD': '/builds/slave/test', 22:23:15 INFO - 'SHELL': '/bin/bash', 22:23:15 INFO - 'SHLVL': '1', 22:23:15 INFO - 'TERM': 'linux', 22:23:15 INFO - 'TMOUT': '86400', 22:23:15 INFO - 'USER': 'cltbld', 22:23:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:15 INFO - '_': '/tools/buildbot/bin/python'} 22:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 INFO - Cleaning up... 22:23:15 INFO - Return code: 0 22:23:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:15 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 22:23:15 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 22:23:15 INFO - Using env: {'DISPLAY': ':0', 22:23:15 INFO - 'HOME': '/home/cltbld', 22:23:15 INFO - 'LANG': 'en_US.UTF-8', 22:23:15 INFO - 'LANGUAGE': 'en_US:en', 22:23:15 INFO - 'LOGNAME': 'cltbld', 22:23:15 INFO - 'MAIL': '/var/mail/cltbld', 22:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:15 INFO - 'MOZ_NO_REMOTE': '1', 22:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:15 INFO - 'NO_EM_RESTART': '1', 22:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:15 INFO - 'PWD': '/builds/slave/test', 22:23:15 INFO - 'SHELL': '/bin/bash', 22:23:15 INFO - 'SHLVL': '1', 22:23:15 INFO - 'TERM': 'linux', 22:23:15 INFO - 'TMOUT': '86400', 22:23:15 INFO - 'USER': 'cltbld', 22:23:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:15 INFO - '_': '/tools/buildbot/bin/python'} 22:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:16 INFO - Downloading/unpacking jsonschema 22:23:16 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 22:23:16 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 22:23:16 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 22:23:16 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 22:23:16 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 22:23:16 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 22:23:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:23:17 INFO - Downloading/unpacking functools32 (from jsonschema) 22:23:17 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 22:23:17 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 22:23:17 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 22:23:17 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 22:23:17 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 22:23:17 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 22:23:18 INFO - Downloading functools32-3.2.3-2.tar.gz 22:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:23:18 INFO - warning: no files found matching '*.txt' 22:23:18 INFO - no previously-included directories found matching 'build' 22:23:18 INFO - no previously-included directories found matching 'dist' 22:23:18 INFO - no previously-included directories found matching '.git*' 22:23:18 INFO - Installing collected packages: jsonschema, functools32 22:23:18 INFO - Running setup.py install for functools32 22:23:18 INFO - warning: no files found matching '*.txt' 22:23:18 INFO - no previously-included directories found matching 'build' 22:23:18 INFO - no previously-included directories found matching 'dist' 22:23:18 INFO - no previously-included directories found matching '.git*' 22:23:18 INFO - Successfully installed jsonschema functools32 22:23:18 INFO - Cleaning up... 22:23:18 INFO - Return code: 0 22:23:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:18 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 0x7fa02bf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, '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': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', '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 22:23:18 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 22:23:18 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 22:23:18 INFO - Using env: {'DISPLAY': ':0', 22:23:18 INFO - 'HOME': '/home/cltbld', 22:23:18 INFO - 'LANG': 'en_US.UTF-8', 22:23:18 INFO - 'LANGUAGE': 'en_US:en', 22:23:18 INFO - 'LOGNAME': 'cltbld', 22:23:18 INFO - 'MAIL': '/var/mail/cltbld', 22:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:18 INFO - 'MOZ_NO_REMOTE': '1', 22:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:18 INFO - 'NO_EM_RESTART': '1', 22:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:18 INFO - 'PWD': '/builds/slave/test', 22:23:18 INFO - 'SHELL': '/bin/bash', 22:23:18 INFO - 'SHLVL': '1', 22:23:18 INFO - 'TERM': 'linux', 22:23:18 INFO - 'TMOUT': '86400', 22:23:18 INFO - 'USER': 'cltbld', 22:23:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:18 INFO - '_': '/tools/buildbot/bin/python'} 22:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:18 INFO - Downloading/unpacking flake8 22:23:18 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 22:23:18 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 22:23:18 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 22:23:18 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 22:23:18 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 22:23:18 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 22:23:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:23:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:23:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:23:21 INFO - no previously-included directories found matching 'docs/_build' 22:23:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:23:21 INFO - Running setup.py install for pep8 22:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:23:21 INFO - no previously-included directories found matching 'docs/_build' 22:23:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:23:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:23:21 INFO - Cleaning up... 22:23:21 INFO - Return code: 0 22:23:21 INFO - Running post-action listener: _resource_record_post_action 22:23:21 INFO - Running post-action listener: _start_resource_monitoring 22:23:21 INFO - Starting resource monitoring. 22:23:21 INFO - ##### 22:23:21 INFO - ##### Running install step. 22:23:21 INFO - ##### 22:23:21 INFO - Running pre-action listener: _resource_record_pre_action 22:23:21 INFO - Running main action method: install 22:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:21 INFO - Reading from file tmpfile_stdout 22:23:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:23:21 INFO - Reading from file tmpfile_stdout 22:23:21 INFO - Output received: 22:23:21 INFO - Usage: mozinstall [options] installer 22:23:21 INFO - Options: 22:23:21 INFO - -h, --help show this help message and exit 22:23:21 INFO - -d DEST, --destination=DEST 22:23:21 INFO - Directory to install application into. [default: 22:23:21 INFO - "/builds/slave/test"] 22:23:21 INFO - --app=APP Application being installed. [default: firefox] 22:23:21 INFO - mkdir: /builds/slave/test/build/application 22:23:21 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'] 22:23:21 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 22:23:37 INFO - Reading from file tmpfile_stdout 22:23:37 INFO - Output received: 22:23:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:37 INFO - Running post-action listener: _resource_record_post_action 22:23:37 INFO - ##### 22:23:37 INFO - ##### Running run-tests step. 22:23:37 INFO - ##### 22:23:37 INFO - Running pre-action listener: _resource_record_pre_action 22:23:37 INFO - Running main action method: run_tests 22:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:37 INFO - Python 2.7.3 22:23:37 INFO - Return code: 0 22:23:37 INFO - grabbing minidump binary from tooltool 22:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:37 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 0x1af3410>, '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 0x1af4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:37 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 22:23:37 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 22:23:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:37 INFO - Return code: 0 22:23:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:23:38 INFO - Return code: 0 22:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:23:38 INFO - Using env: {'DISPLAY': ':0', 22:23:38 INFO - 'HOME': '/home/cltbld', 22:23:38 INFO - 'LANG': 'en_US.UTF-8', 22:23:38 INFO - 'LANGUAGE': 'en_US:en', 22:23:38 INFO - 'LOGNAME': 'cltbld', 22:23:38 INFO - 'MAIL': '/var/mail/cltbld', 22:23:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:38 INFO - 'MOZ_NO_REMOTE': '1', 22:23:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:38 INFO - 'NO_EM_RESTART': '1', 22:23:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:38 INFO - 'PWD': '/builds/slave/test', 22:23:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:38 INFO - 'SHELL': '/bin/bash', 22:23:38 INFO - 'SHLVL': '1', 22:23:38 INFO - 'TERM': 'linux', 22:23:38 INFO - 'TMOUT': '86400', 22:23:38 INFO - 'USER': 'cltbld', 22:23:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461211724.765807-1510309866', 22:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:38 INFO - '_': '/tools/buildbot/bin/python'} 22:23:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:23:38 INFO - mozversion application_buildid: 20160420210806 22:23:38 INFO - mozversion application_changeset: 85616706a29b8944f3a09f5cc32e9e219f6ceb40 22:23:38 INFO - mozversion application_display_name: Nightly 22:23:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:38 INFO - mozversion application_name: Firefox 22:23:38 INFO - mozversion application_remotingname: firefox 22:23:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:23:38 INFO - mozversion application_vendor: Mozilla 22:23:38 INFO - mozversion application_version: 48.0a1 22:23:38 INFO - mozversion platform_buildid: 20160420210806 22:23:38 INFO - mozversion platform_changeset: 85616706a29b8944f3a09f5cc32e9e219f6ceb40 22:23:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:23:38 INFO - mozversion platform_version: 48.0a1 22:23:38 INFO - using testdate: 1461216218 22:23:38 INFO - actual date: 1461216218 22:23:38 INFO - starting webserver on 'localhost:57007' 22:23:38 INFO - SUITE-START | Running 2 tests 22:23:38 INFO - TEST-START | dromaeo_css 22:23:38 INFO - operating with platform_type : linux_ 22:23:38 INFO - Initialising browser for dromaeo_css test... 22:23:38 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnRkd8s/profile http://localhost:57007/getInfo.html) 22:23:44 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 22:23:44 INFO - PROCESS | 3308 | colorDepth:24 22:23:44 INFO - PROCESS | 3308 | Browser inner width/height: 1024/697 22:23:44 INFO - PROCESS | 3308 | __metrics 22:23:45 ERROR - PROCESS | 3308 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:23:46 INFO - TEST-INFO | 3308: exit 0 22:23:46 INFO - Browser initialized. 22:23:46 INFO - Running cycle 1/1 for dromaeo_css test... 22:23:46 INFO - TEST-INFO | started process 3393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnRkd8s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:58 INFO - PROCESS | 3393 | RSS: Main: 154755072 22:23:58 INFO - PROCESS | 3393 | 22:24:50 INFO - PROCESS | 3393 | 1461216290065 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] 22:27:01 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57007/tests/dromaeo/cssquery-ext.html) 22:27:02 INFO - PROCESS | 3393 | RSS: Main: 264228864 22:27:02 INFO - PROCESS | 3393 | 22:30:05 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-ext.html (next: http://localhost:57007/tests/dromaeo/cssquery-jquery.html) 22:30:05 INFO - PROCESS | 3393 | RSS: Main: 231788544 22:30:05 INFO - PROCESS | 3393 | 22:33:07 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57007/tests/dromaeo/cssquery-mootools.html) 22:33:08 INFO - PROCESS | 3393 | RSS: Main: 227086336 22:33:08 INFO - PROCESS | 3393 | 22:36:10 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57007/tests/dromaeo/cssquery-prototype.html) 22:36:11 INFO - PROCESS | 3393 | RSS: Main: 226959360 22:36:11 INFO - PROCESS | 3393 | 22:39:14 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57007/tests/dromaeo/cssquery-yui.html) 22:39:14 INFO - PROCESS | 3393 | RSS: Main: 210903040 22:39:14 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:57007/tests/dromaeo/cssquery-yui.html (next: http://localhost:57007/tests/dromaeo/cssquery-dojo.html) 22:42:17 INFO - PROCESS | 3393 | RSS: Main: 270487552 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | __start_tp_report 22:42:17 INFO - PROCESS | 3393 | _x_x_mozilla_page_load 22:42:17 INFO - PROCESS | 3393 | _x_x_mozilla_page_load_details 22:42:17 INFO - PROCESS | 3393 | |i|pagename|runs| 22:42:17 INFO - PROCESS | 3393 | |0;dojo.html;2551.5534781413253;2616.2020583721956;2630.395009147896;2633.947321053578;2651.9999999999995;4431;4513.165064463076;4563.2470642344015;4601.815927362902;4609.0781843631285;4558.566936141069;4591.793369298382;4612.146752850725;4674.7428891410955;4679.719216846992;4208.97895510522;4214.178235244129;4244.427002354689;4269.274223382017;4362.650987920959;4256.404103425508;4320.740755554677;4330.545292744264;4338.522762496123;4372.89067773305;4100.979495102535;4163.459519977628;4247.766372849492;4260.68044896634;4344.782760861945;4239.512456067561;4260.659147268211;4264.275073237557;4264.552222016675;4315.6763242756915;4252.383404406375;4255.0426154115385;4259.8509052183335;4280.59334363235;4281.807318670636;4352.7823608819745;4495.685302028859;4517.028838799673;4560.680752347337;4579.358889755437;4885.7312847793355;4901.191303434929;4901.313816065754;4901.387326584177;4930.778114984834;4803.543663351976;4947.307376967227;4953.554180123806;4953.653244272902;4996.100701873661;4588.0365123324145;4635.559621835921;4646.3495110684535;4650.906981860344;4663.906721865544;4961.950380496149;4982.252662100714;4989;4996.100701873697;5029.7736601853;4786.1863483207935;4795.184818580849;4797.2564252540915;4809.278608208797;4848.10310092634;4756.21522448799;4866.489018653061;4927.7536123193695;4952;4955.40535135786;4899.559039686445;4906.484819094015;4913.533214344631;4916.360873086547;4969.0310389474425;4882.536159064884;4894.241392584155;4902.41171059468;4909.558139767438;4964.528369804862;3946.5856085111222;3988.980055099706;4017.015831121394;4025.698072644505;4028.798560071985;3584.8566057357934;3587.6053634100226;3615.8192090395373;3615.837287322077;3647.3434781739543;4248.511421186541;4248.575142485726;4252.149570085933;4287.485501739811;4290.442242508454;4731.881702957454;4856.125897338442;4858.368412106474;4871;4927.482614325516;4316.719413238129;4324.200022995756;4330.978345108254;4343.391925130484;4349.565043495689;4410.713303635253;4441.133978874089;4454.198244316054;4456.197884380843;4493.326001099861;4567.086582683411;4706.882327941828;4747.952520474889;4754.477007529169;4759.619230461485;4881.780319885543;4891.657583969088;4894.828680996148;4897.657163998486;4914.311996320446;4636.142313671981;4663.976680116578;4681.625469962463;4685.344051832814;4719.3628860103445;4675.368825208553;4860.635452341018;4875.561199492063;4925.581325587222;4937.9259311109645;4940.802367905388;4946.183879659816;4958.231474121517;4958.826441074545;5011.874703132451;4800.783964721666;4826.251930950708;4830.058138662927;4839.056384005085;4860.756962151808;4653.302004699322;4780.521947805191;4826.58973987215;4828.734419606815;4833.73414462208;4663.743494107856;4677.2750223715375;4684.672072954861;4685.344051832814;4731.172044892061;4746.5490778376;4784.593309568726;4787.18617834962;4792.7124372537755;4848.7090774553635;4671.85984420468;4705.717656940595;4732.124556956974;4764.952350476451;4778.832740854054 22:42:17 INFO - PROCESS | 3393 | |1;ext.html;556.1241045353569;593.8040446652606;595.431363048289;605.6759633596024;606.9696515174246;26326.34184145395;33171.66828331716;34092.318153636916;34171.658283417186;34326.65673343266;36464.81767591158;37092;37201.255974880485;37232.44151337732;37242.8137859311;7451.254874512546;7594.430417718693;7610.695572177106;7623.161452240249;7629.961850190742;7338.706451741924;7417.072865891763;7440;7447.590382528959;7641.7707468776025;7609.619519024054;7645.655945482466;7646.770596882075;7646.961765191167;7650.540967541938;7564.130125035609;7615.16233214346;7635.580043097628;7642.617869106522;7642.7325043623205;7741.496802707806;7844.646990885367;7849.764507064797;7851.489653172525;7856.567888766115;37038;37516;37549.249015019544;37570.812145939366;37590.62409375898;3009.9849500752575;3190.7287880530184;3396.7961922284494;3729.4032954727113;3798.1074447504816;25958.480830383476;25974.610380844304;27455.45089098207;29297.56053659197;30062.54906176409;3509.4209455439823;3513.402721537345;3531.170175008871;3620.348337299285;3735.794531300777;167673;168112;168336.1583192076;168464;169234;32410.83794581012;33281.167970800925;49622.50377496251;50437;50536;31669.52495712566;31761.841190793897;31791.18505779275;31847.363052739278;31883.681163188536;12165.75668486643;12379.75240495203;12381.504739810307;12399.504019839285;12408.875911240953;9936.453495057696;10000.849987250198;10005.79988400228;10011.79976400468;10013.49932503372;8098.797530061795;8112.391570632226;8152.796180095545;8191.631376588068;8220.177982201732;3165.7625678074237;3195.2331440454122;3199.856006479714;3203.951940720891;3231.919202019921;836.1763662792144;846.9449485783405;877.2762470961483;877.7542288159326;912.780932576177;27423.725762742117;28177;28735.712642873303;28756.856215718788;28757.56863647047;963.7253382785873;1012.119456073221;1050;1060.7295139739317;1101.2951710905027;15028.699426011419;15144.621384465256;15162.772558411632;15256.618584535254;15300.699440547456;336749;341205;342615;343305;344560;46700.06599868052;47554.28668569974;47629.28556071662;47676.523234767905;47751;983.1004630762772;1023.9641612543675;1099.4118146791589;1187.4656404617956;1218.823270625772;25306.493870122125;25805.870970645028;26342;26470.470590588466;26699.866500668148;36247.45628815517;36470;36834;36862.44706329353;36863.262734745695;186494.2025869586;187400;188311;188607;189086;22130.778692212873;23900;24665.876670616533;25196.87401563054;25313.620295695946;36048.03471618067;36293.27413451769;36345.454818178274;36879.81560092182;37292.440613391365;33604.663953360156;33805.492917606745;34174.31651366909;34293;34384.82807586046;33168.668313317525;33799;33947.49078763771;34127.488087678204;34135.65864341325;35196.648033519334;35457.64542354544;36164.4575331365;36394.27211455703;36714.26571468609;26357.604635930093;28964.565531516622;28985;29098.272543185743;29175.124746257647;23108.306750797503;23127.537449251256;23570;24433.75566244315;24606.630900536147 22:42:17 INFO - PROCESS | 3393 | |2;jquery.html;356.59704533876726;361.47586000299566;364.4151137424435;377.9508663873696;379.11098474078295;15778.447754328601;16251.674966500663;16587.087710175965;16641.41755038574;16675.166241687926;14560.490382836602;16545.338186472556;16657.83342166578;16860;16861.40985065523;4849.806007759694;5091.363579552556;5113.488651134875;5129.897402051956;5140.074786538422;3630.8366123524374;5045.772940217681;5489.890202195954;5788.47903688668;5818.0981947798155;5737.913931291034;5742.196092547047;5761.510271626917;5763.020286551276;5773.971130144343;5587.1339942309005;5668.31980162379;5724.341700704431;5725.198472213893;5756.942430575725;3302.5871766029245;4750.168720473903;5000.449950505442;5010.448850626428;5015.473375295578;18898.52753681155;19245.615087698166;19310.903445482683;20276.493087672778;20303.89848050765;1866.925322987079;1890.6880364739802;1967.3606078024557;2225.4436390902274;2537.949241015188;12864.549740759123;13079.28063956482;13184.472621095145;13381.330933453288;13602.31988400576;1705.7782488276569;1734.2802736864187;1814.639020734449;1867.5891303913118;1883.4632129842928;60532.39467605312;60855.39144608586;61647.07529387063;62938.0559291611;63420;9053.547322633842;9130.31522635805;9327.860082098774;9679.886813016594;9693.563789629483;12898.67753306175;12930.870691293156;12945.805812912813;12969.805452918214;12985.636508166506;6993.0908981832035;7018.368346848706;7136.964315178391;7206.243344448862;7223.1693355264815;6784.59292442455;6873.621950792654;6945.548539344926;6953.443724502028;6958.617276049765;5969.462748352582;6048.637081775108;6083.11794789753;6108.816735497942;6118.969405152946;1532.494276888624;1650.6698660267994;1655.908925009112;1667.7831881855282;1683.5706894741763;846.9068402475723;848.5248260973874;860.4966094834592;860.8837806896114;919.0671468459519;16473.6705265894;17263.3957811476;17306.134693265285;17812.287508499776;18126.63746725058;874.7594411536751;885.9468431894107;889.2841262783521;905.8777065096259;936.9672061477816;9820.165285950632;9882.308238423242;10140.797184056277;10148.797024059477;10195.592176312864;376475;387112;395172;395814;398221;72238.63880680563;73104.63447682835;73813;73874;74123;948.5684013773716;949.3923888711369;969.1132613658424;987.5457289646843;989.7426669065951;15531.22343882824;15743.527694169194;15754.684906302038;15871.2064396782;16152.67694646077;30619.846900765355;31933;32575.674243257265;32735.83632081824;33777;45930.54069459396;46238.30642540432;46633.76683116562;47123.29315060208;47197.29204061873;7510.57443710308;7524.473286869867;7695.461317707706;7784.987951566261;7807.765767026998;11957.043436525231;12050.397480126134;12161.33112678811;12180.695482613006;12303.93848030754;10545.261831672016;10671.413072281099;10712.625058122929;11061.723456913642;11079.83380249313;10522.368657880552;10540.472976351306;10638.680839574825;10709.357438553712;10824.783504330027;10812.729681758019;10849.566017359533;10889.128869690247;11010;11171.273867198606;7434.584244311904;7462.403007759474;7478.925210748041;7583.544987300779;7776.222377762178;9492.525373731423;10060.245481588763;10084.596616135566;10310.587576497157;10838.403887786248 22:42:17 INFO - PROCESS | 3393 | |3;mootools.html;1231.6305108467457;1423.1390009044524;1462.8902832287579;1581.8418158184184;1763.4357005758154;7366.152892417374;7688.038995125609;7701.884471732915;7710.344620707233;7714.421418393622;7503.699852005913;7637.579933103677;7651.387888968883;7655.808604784883;7658.92341076589;1827.3147569661378;2164.632012557869;2182;2191.824654027674;2252.650839119939;2255.221948427798;2268.296827983322;2280.395695140789;2285.8171346292256;2285.908563657452;2205.283282933045;2252.6621006849023;2253.876036817974;2254.2786308381324;2255.154317131076;1890.395073576456;2088.6553718636483;2141.453929248047;2143.517708515587;2147.7315335583053;2172.424307558498;2188.912443502258;2195.3633446300555;2196.967045494319;2201.680756290345;7685.154632990367;7709.2290770922455;7745.496542724705;7754;7759.2628700273945;4301.505326887417;4425.491068527129;4427.822887084512;4447.1995040892625;4491.865244042684;2943.396603696237;2960.955585666217;2963.4517614241436;2963.881444742208;3038.2404398900276;973.8101070291297;991.6826615483048;996.940183588987;1004.5780772075673;1011.4133802394593;10426.687199384107;10430.843537346946;10452.16382689383;10465.9476702616;10469.84295235572;4137.8965525861495;4176.206520761046;4292;4344.956550434518;4421.46942366918;8060.516369017878;8062.879056814152;8105.75682729519;8137.064237612632;8150.9184908150155;4017.8995525112105;4487.708298960557;4501.054778496552;4515.119551687455;4522.592966632953;3794.6395092466723;3826.7895265760094;3828.2917660232947;3832.0419895026243;4184.790760461965;3435.3301106284534;3440.587129544421;3547.6629720176543;3576.2668652926086;3579.8926032219074;1032.8450732390202;1092.1317552545745;1093.4532733633184;1101.0475938313302;1110.6168371911679;852.9232369086687;862.2498426369099;862.5256109139948;899.9775005624781;907.6687009241712;5476.863078423071;5565.582581306418;5574.9721251393485;5784.161296611967;5820.388859169726;897.6499165325529;927.6196759328777;936.9200375167118;939.1406862720535;953.6614501851882;3600.8199590020395;3625.274945011008;3729.1050147964293;3760.567534733486;3842.366009608383;9305.25557955362;9653.22774178064;9691.176250018687;9729.708108756608;9739.366941148803;9555.474448905377;9596.18432433251;9599.32804703664;9622.566984485715;9646.421214727;6876.518643694893;7094.290570942864;7188.5327453715345;7188.748393806191;7228.963855180796;5343.4389389113585;5483.396826349019;5488.670679759227;5507.614466987273;5613;8761.5181165034;8796.560171991503;8868.86696699537;8872.512011839412;8893.288536916902;8445.831083378174;8581.227689507974;8672;8791.648334066565;8798.868016979623;6151.384861513813;6636.668166591555;6666.799996000128;6873.072135261676;6873.862522749417;7419.777406677808;7432.925670743223;7476.4018878488505;7493.812654683677;7510.511816731895;6598.076269322202;6739.5619284746335;6768.593884366954;6830.282820303995;6926.168859736864;6682.665866706742;6756.256811750802;6793.558418702769;6859.211190713132;6865.41643960249;6183.81448556544;6313.526485513697;6361.332060133805;6369.1401660777055;6375.713092910923;4728.574428301469;4753.857384278477;4789.353437285922;4799.880002999953;4836.93587410769;4818.38584074339;4849.127157111754;4888.31563581106;4905.23968784839;4915.582175515121 22:42:17 INFO - PROCESS | 3393 | |4;prototype.html;303.43712413473;303.6356372353177;305.11060259344015;317.61727118821824;317.91416317594235;4999.950000499994;5013.273075404064;5034.144195486767;5034.295198672189;5063.341765570471;4945.6043516518685;4948.430930443;4966.70199788013;4976.825811096613;4978.477259887714;3688.5942546319884;3744.4383342498572;3926.5877082906313;3928.9803550982206;3945.329294020009;3873.6513713765758;3917.804109794499;3922.2743792398355;3929.0963078491964;3939.1727737175083;3618.8190590470504;3885.805709714517;3895.61043895611;3906.5898080701545;3908.257431088098;3753.2868754936476;3881.6312450317314;3883.2233553289457;3903.6291552302487;3905;3419.777714448553;3439.2777516721517;3446.8104254266004;3451.706604938558;3454.6199918008997;4761.8095276188915;4764.547368000034;4765.952340476586;4769.76151192439;4798.49615790344;4312.547182545819;4453.933191002137;4464.754438505881;4473.105378924196;4491.124230774967;5177.974110129463;5195.402528709209;5207.4011488678525;5211.1922651989;5224.63427560071;3766.9058273543105;3769.2838360711376;3773.6981041516615;3779.848806047755;3791.905202369935;5257.185136303879;5443.237946687467;5457.727113644302;5476.972615136939;5477.7261136943;3836.8848934532007;3851.7496362736892;3861.2470568239487;3864.1112544115012;3868.709846761504;3926.096997690547;3926.6858651307825;3933.586973367755;3933.9016524587114;3936.3701807710627;4443.089166720814;4444.533324000933;4447.666425018137;4452.621527170227;4453.487848897418;4883.658143929962;5137.306463627362;5158.561522270649;5194.35070616173;5203.453637368098;1307.4508706343358;1329.0497294434526;1329.654289884637;1329.9468021279233;1334.6463187255385;839.8446287436843;871.949301092195;884.6284560484612;886.5655828644047;907.5054095517827;4625.537446255347;4656.95343046572;4661.3707149534375;4673.836415725501;4680.625549955996;5322.350071477854;5333.599980001438;5335.786568537293;5339.092354299778;5340.145576707708;4483.103379324149;4586.495485496593;4593.242115050979;4614.861554153314;4632;2819.7039310872474;2841.5169421198448;2843.061789609424;2849.2734352739917;2853;5076.847694569169;5088.898222035613;5091.261767043758;5093.490650934951;5097.439281679012;5283.577313814885;5463.2078348639225;5463.9072185563045;5465.480779326037;5488.451154884559;5041.924371134436;5070.366204224472;5072.15959062926;5073.619478539124;5099.923501147486;5288.4182739897815;5293.179557168491;5312.229726689531;5313;5333.813316533902;5021.7740201690285;5199.610029247897;5219.347581552306;5226.4581948326095;5229.843104706865;5056.266841307916;5059.519345662156;5059.949400506095;5068.113080211022;5075.543201111917;3749.775013499199;3755.310110450363;3757.1170774868433;3770.792606406674;3772.905677358088;5198.116320225647;5241.240020197126;5304.363476382859;5314.415414304346;5325.547328477122;5142.820001299937;5151.2273159026445;5156.329677141947;5164.9741751291;5170.7156106413;5159.458256882973;5164.586833053271;5167.328247327823;5170.560502357342;5177.249298851721;4926.531979461945;5087.694738315713;5149.176131818891;5187.896242075213;5206.167013278009;5029.497050294941;5116.334876466036;5242.423333433396;5274;5324.121519949165;5186.870328241824;5189.818356357509;5191.480851914929;5203.580335144176;5208.869778255423 22:42:17 INFO - PROCESS | 3393 | |5;yui.html;692.6848284030765;706.2266817834469;722.6820199112391;786.6931896560343;788.8027993001749;10843.891561084387;11278.266912650683;11480.081593472523;11484.966353028225;11505;11621.360825154614;11664.475098620562;11695.941520292386;11698.590549330775;11705.3562054087;621.8258887511504;763.526613499631;781.0432220529848;789.4237206839011;795.9084705258882;785.8781888807215;786.1941509952316;790.8220650353682;792;792.1642666986327;819.4468733604793;823.9711610093648;824.0194168938973;824.6206744897354;824.9505029698207;656.9441597464221;812.8821320908494;831.6922738586761;831.9500829950223;831.9916800831975;612.185792895448;612.2683393344954;612.3386742318286;612.4059662127729;612.9049997250434;11290.983811456927;11316.943415282953;11379;11392.94303528477;11432.657020289405;11472.369019703912;11789.882101178964;11799.646010619696;12032.27806331623;12102.576409825613;9445.52772361386;9657.565409556586;9750.268729845218;9843.950780246125;9961.501924903798;3194.853233632964;3199.392115498048;3258.201740573551;3268.084936217863;3294.439945209296;43016.784916075216;43266.13467730659;43396.34905476389;43813.56186438127;44906.10187796258;9188.26493880488;9250.4912229828;9296.8605470918;9363.391379560308;9406.153446189875;14778.778318325234;15587.688246235011;15601.765973510406;15625.453109141126;15638.3744650215;6772.932270677329;6871.347222013901;6920.169579650475;6964.4428445724225;6970.128733908262;3497.667721566447;3576.2311103112434;3625.6374362563533;3647.252313275825;3744.962550374516;2680.32991752062;2745.3136715821047;2746.8489233092373;2761.295869553251;2767.2805070681766;463.36518969011996;480.0590841949817;508.01952232191485;522.4931816138339;523.5706720489162;566.5892228134652;626.9655168965751;647.6923461355913;653.3401264722569;669.9531032827753;7576.475044985351;7767.300942915164;7790.79297179528;7969.8406031880195;8027.197280272043;609.3936533149545;625.3465128940269;630.7673174978237;639;645.4642646603402;3706.258748250361;3822.025383527183;3836.290286297044;3955.2880481513603;3998.520177578651;39880.41674165619;43169.784151079046;43362.78318608387;43382.566174338484;43452.78273608612;37233.25533489315;38986.41520377197;39399;39633.20733585312;42523.57476425258;38007.80996095002;38080.61919380826;38434.99999999944;38861;40427.1914561713;7652.311291983749;7847.568383738949;8138.186181381814;8220.83558328842;8245.093039765741;23519.52960940806;26015.479690406464;26206.475870482103;26497.735022649525;26981.73018269792;33468.163295917795;35350.46974295336;36549.71052605278;36976.445353319185;37427.064323391045;9592.808143837225;9659.46872921996;9718.9028109718;9893.35693179941;9908.207343412654;11271.605493808005;11356.716082098013;11392.48733806964;11609.88390116088;11666.241694289844;10594.20543459259;10710.518026688662;10769.13846892231;10844.891551084704;11183.273087249303;11268.605598804003;11323.377214252965;11415.942920285677;11899;11973.281603103842;10713.785724285315;11068.944655276671;11079.5568177272;11225.719357015812;11619.128565357463;9276.768080798034;9422.19911307519;9567.234621230424;9589.42463452195;9670.129688328085;9288.34981551285;9353.345265831327;9388.95305523468;9398.2951278653;9399.295052871199 22:42:17 INFO - PROCESS | 3393 | __end_tp_report 22:42:17 INFO - PROCESS | 3393 | __start_cc_report 22:42:17 INFO - PROCESS | 3393 | _x_x_mozilla_cycle_collect,1032 22:42:17 INFO - PROCESS | 3393 | __end_cc_report 22:42:17 INFO - PROCESS | 3393 | __startTimestamp1461217337711__endTimestamp 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | ------- Summary: start ------- 22:42:17 INFO - PROCESS | 3393 | Number of tests: 6 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#0] dojo.html Cycles:165 Average:4547.19 Median:4679.72 stddev:469.19 (10.0%) stddev-sans-first:443.75 22:42:17 INFO - PROCESS | 3393 | Values: 2551.6 2616.2 2630.4 2633.9 2652.0 4431.0 4513.2 4563.2 4601.8 4609.1 4558.6 4591.8 4612.1 4674.7 4679.7 4209.0 4214.2 4244.4 4269.3 4362.7 4256.4 4320.7 4330.5 4338.5 4372.9 4101.0 4163.5 4247.8 4260.7 4344.8 4239.5 4260.7 4264.3 4264.6 4315.7 4252.4 4255.0 4259.9 4280.6 4281.8 4352.8 4495.7 4517.0 4560.7 4579.4 4885.7 4901.2 4901.3 4901.4 4930.8 4803.5 4947.3 4953.6 4953.7 4996.1 4588.0 4635.6 4646.3 4650.9 4663.9 4962.0 4982.3 4989.0 4996.1 5029.8 4786.2 4795.2 4797.3 4809.3 4848.1 4756.2 4866.5 4927.8 4952.0 4955.4 4899.6 4906.5 4913.5 4916.4 4969.0 4882.5 4894.2 4902.4 4909.6 4964.5 3946.6 3989.0 4017.0 4025.7 4028.8 3584.9 3587.6 3615.8 3615.8 3647.3 4248.5 4248.6 4252.1 4287.5 4290.4 4731.9 4856.1 4858.4 4871.0 4927.5 4316.7 4324.2 4331.0 4343.4 4349.6 4410.7 4441.1 4454.2 4456.2 4493.3 4567.1 4706.9 4748.0 4754.5 4759.6 4881.8 4891.7 4894.8 4897.7 4914.3 4636.1 4664.0 4681.6 4685.3 4719.4 4675.4 4860.6 4875.6 4925.6 4937.9 4940.8 4946.2 4958.2 4958.8 5011.9 4800.8 4826.3 4830.1 4839.1 4860.8 4653.3 4780.5 4826.6 4828.7 4833.7 4663.7 4677.3 4684.7 4685.3 4731.2 4746.5 4784.6 4787.2 4792.7 4848.7 4671.9 4705.7 4732.1 4765.0 4778.8 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#1] ext.html Cycles:180 Average:37803.92 Median:188394.66 stddev:64605.39 (34.3%) stddev-sans-first:64726.09 22:42:17 INFO - PROCESS | 3393 | Values: 556.1 593.8 595.4 605.7 607.0 26326.3 33171.7 34092.3 34171.7 34326.7 36464.8 37092.0 37201.3 37232.4 37242.8 7451.3 7594.4 7610.7 7623.2 7630.0 7338.7 7417.1 7440.0 7447.6 7641.8 7609.6 7645.7 7646.8 7647.0 7650.5 7564.1 7615.2 7635.6 7642.6 7642.7 7741.5 7844.6 7849.8 7851.5 7856.6 37038.0 37516.0 37549.2 37570.8 37590.6 3010.0 3190.7 3396.8 3729.4 3798.1 25958.5 25974.6 27455.5 29297.6 30062.5 3509.4 3513.4 3531.2 3620.3 3735.8 167673.0 168112.0 168336.2 168464.0 169234.0 32410.8 33281.2 49622.5 50437.0 50536.0 31669.5 31761.8 31791.2 31847.4 31883.7 12165.8 12379.8 12381.5 12399.5 12408.9 9936.5 10000.8 10005.8 10011.8 10013.5 8098.8 8112.4 8152.8 8191.6 8220.2 3165.8 3195.2 3199.9 3204.0 3231.9 836.2 846.9 877.3 877.8 912.8 27423.7 28177.0 28735.7 28756.9 28757.6 963.7 1012.1 1050.0 1060.7 1101.3 15028.7 15144.6 15162.8 15256.6 15300.7 336749.0 341205.0 342615.0 343305.0 344560.0 46700.1 47554.3 47629.3 47676.5 47751.0 983.1 1024.0 1099.4 1187.5 1218.8 25306.5 25805.9 26342.0 26470.5 26699.9 36247.5 36470.0 36834.0 36862.4 36863.3 186494.2 187400.0 188311.0 188607.0 189086.0 22130.8 23900.0 24665.9 25196.9 25313.6 36048.0 36293.3 36345.5 36879.8 37292.4 33604.7 33805.5 34174.3 34293.0 34384.8 33168.7 33799.0 33947.5 34127.5 34135.7 35196.6 35457.6 36164.5 36394.3 36714.3 26357.6 28964.6 28985.0 29098.3 29175.1 23108.3 23127.5 23570.0 24433.8 24606.6 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#2] jquery.html Cycles:180 Average:23911.58 Median:391142.00 stddev:64181.16 (16.4%) stddev-sans-first:64336.83 22:42:17 INFO - PROCESS | 3393 | Values: 356.6 361.5 364.4 378.0 379.1 15778.4 16251.7 16587.1 16641.4 16675.2 14560.5 16545.3 16657.8 16860.0 16861.4 4849.8 5091.4 5113.5 5129.9 5140.1 3630.8 5045.8 5489.9 5788.5 5818.1 5737.9 5742.2 5761.5 5763.0 5774.0 5587.1 5668.3 5724.3 5725.2 5756.9 3302.6 4750.2 5000.4 5010.4 5015.5 18898.5 19245.6 19310.9 20276.5 20303.9 1866.9 1890.7 1967.4 2225.4 2537.9 12864.5 13079.3 13184.5 13381.3 13602.3 1705.8 1734.3 1814.6 1867.6 1883.5 60532.4 60855.4 61647.1 62938.1 63420.0 9053.5 9130.3 9327.9 9679.9 9693.6 12898.7 12930.9 12945.8 12969.8 12985.6 6993.1 7018.4 7137.0 7206.2 7223.2 6784.6 6873.6 6945.5 6953.4 6958.6 5969.5 6048.6 6083.1 6108.8 6119.0 1532.5 1650.7 1655.9 1667.8 1683.6 846.9 848.5 860.5 860.9 919.1 16473.7 17263.4 17306.1 17812.3 18126.6 874.8 885.9 889.3 905.9 937.0 9820.2 9882.3 10140.8 10148.8 10195.6 376475.0 387112.0 395172.0 395814.0 398221.0 72238.6 73104.6 73813.0 73874.0 74123.0 948.6 949.4 969.1 987.5 989.7 15531.2 15743.5 15754.7 15871.2 16152.7 30619.8 31933.0 32575.7 32735.8 33777.0 45930.5 46238.3 46633.8 47123.3 47197.3 7510.6 7524.5 7695.5 7785.0 7807.8 11957.0 12050.4 12161.3 12180.7 12303.9 10545.3 10671.4 10712.6 11061.7 11079.8 10522.4 10540.5 10638.7 10709.4 10824.8 10812.7 10849.6 10889.1 11010.0 11171.3 7434.6 7462.4 7478.9 7583.5 7776.2 9492.5 10060.2 10084.6 10310.6 10838.4 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#3] mootools.html Cycles:180 Average:5101.57 Median:5498.14 stddev:2799.92 (50.9%) stddev-sans-first:2792.67 22:42:17 INFO - PROCESS | 3393 | Values: 1231.6 1423.1 1462.9 1581.8 1763.4 7366.2 7688.0 7701.9 7710.3 7714.4 7503.7 7637.6 7651.4 7655.8 7658.9 1827.3 2164.6 2182.0 2191.8 2252.7 2255.2 2268.3 2280.4 2285.8 2285.9 2205.3 2252.7 2253.9 2254.3 2255.2 1890.4 2088.7 2141.5 2143.5 2147.7 2172.4 2188.9 2195.4 2197.0 2201.7 7685.2 7709.2 7745.5 7754.0 7759.3 4301.5 4425.5 4427.8 4447.2 4491.9 2943.4 2961.0 2963.5 2963.9 3038.2 973.8 991.7 996.9 1004.6 1011.4 10426.7 10430.8 10452.2 10465.9 10469.8 4137.9 4176.2 4292.0 4345.0 4421.5 8060.5 8062.9 8105.8 8137.1 8150.9 4017.9 4487.7 4501.1 4515.1 4522.6 3794.6 3826.8 3828.3 3832.0 4184.8 3435.3 3440.6 3547.7 3576.3 3579.9 1032.8 1092.1 1093.5 1101.0 1110.6 852.9 862.2 862.5 900.0 907.7 5476.9 5565.6 5575.0 5784.2 5820.4 897.6 927.6 936.9 939.1 953.7 3600.8 3625.3 3729.1 3760.6 3842.4 9305.3 9653.2 9691.2 9729.7 9739.4 9555.5 9596.2 9599.3 9622.6 9646.4 6876.5 7094.3 7188.5 7188.7 7229.0 5343.4 5483.4 5488.7 5507.6 5613.0 8761.5 8796.6 8868.9 8872.5 8893.3 8445.8 8581.2 8672.0 8791.6 8798.9 6151.4 6636.7 6666.8 6873.1 6873.9 7419.8 7432.9 7476.4 7493.8 7510.5 6598.1 6739.6 6768.6 6830.3 6926.2 6682.7 6756.3 6793.6 6859.2 6865.4 6183.8 6313.5 6361.3 6369.1 6375.7 4728.6 4753.9 4789.4 4799.9 4836.9 4818.4 4849.1 4888.3 4905.2 4915.6 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#4] prototype.html Cycles:180 Average:4328.21 Median:4977.65 stddev:1249.51 (25.1%) stddev-sans-first:1215.95 22:42:17 INFO - PROCESS | 3393 | Values: 303.4 303.6 305.1 317.6 317.9 5000.0 5013.3 5034.1 5034.3 5063.3 4945.6 4948.4 4966.7 4976.8 4978.5 3688.6 3744.4 3926.6 3929.0 3945.3 3873.7 3917.8 3922.3 3929.1 3939.2 3618.8 3885.8 3895.6 3906.6 3908.3 3753.3 3881.6 3883.2 3903.6 3905.0 3419.8 3439.3 3446.8 3451.7 3454.6 4761.8 4764.5 4766.0 4769.8 4798.5 4312.5 4453.9 4464.8 4473.1 4491.1 5178.0 5195.4 5207.4 5211.2 5224.6 3766.9 3769.3 3773.7 3779.8 3791.9 5257.2 5443.2 5457.7 5477.0 5477.7 3836.9 3851.7 3861.2 3864.1 3868.7 3926.1 3926.7 3933.6 3933.9 3936.4 4443.1 4444.5 4447.7 4452.6 4453.5 4883.7 5137.3 5158.6 5194.4 5203.5 1307.5 1329.0 1329.7 1329.9 1334.6 839.8 871.9 884.6 886.6 907.5 4625.5 4657.0 4661.4 4673.8 4680.6 5322.4 5333.6 5335.8 5339.1 5340.1 4483.1 4586.5 4593.2 4614.9 4632.0 2819.7 2841.5 2843.1 2849.3 2853.0 5076.8 5088.9 5091.3 5093.5 5097.4 5283.6 5463.2 5463.9 5465.5 5488.5 5041.9 5070.4 5072.2 5073.6 5099.9 5288.4 5293.2 5312.2 5313.0 5333.8 5021.8 5199.6 5219.3 5226.5 5229.8 5056.3 5059.5 5059.9 5068.1 5075.5 3749.8 3755.3 3757.1 3770.8 3772.9 5198.1 5241.2 5304.4 5314.4 5325.5 5142.8 5151.2 5156.3 5165.0 5170.7 5159.5 5164.6 5167.3 5170.6 5177.2 4926.5 5087.7 5149.2 5187.9 5206.2 5029.5 5116.3 5242.4 5274.0 5324.1 5186.9 5189.8 5191.5 5203.6 5208.9 22:42:17 INFO - PROCESS | 3393 | 22:42:17 INFO - PROCESS | 3393 | [#5] yui.html Cycles:180 Average:11756.31 Median:43389.46 stddev:12669.28 (29.2%) stddev-sans-first:12677.58 22:42:17 INFO - PROCESS | 3393 | Values: 692.7 706.2 722.7 786.7 788.8 10843.9 11278.3 11480.1 11485.0 11505.0 11621.4 11664.5 11695.9 11698.6 11705.4 621.8 763.5 781.0 789.4 795.9 785.9 786.2 790.8 792.0 792.2 819.4 824.0 824.0 824.6 825.0 656.9 812.9 831.7 832.0 832.0 612.2 612.3 612.3 612.4 612.9 11291.0 11316.9 11379.0 11392.9 11432.7 11472.4 11789.9 11799.6 12032.3 12102.6 9445.5 9657.6 9750.3 9844.0 9961.5 3194.9 3199.4 3258.2 3268.1 3294.4 43016.8 43266.1 43396.3 43813.6 44906.1 9188.3 9250.5 9296.9 9363.4 9406.2 14778.8 15587.7 15601.8 15625.5 15638.4 6772.9 6871.3 6920.2 6964.4 6970.1 3497.7 3576.2 3625.6 3647.3 3745.0 2680.3 2745.3 2746.8 2761.3 2767.3 463.4 480.1 508.0 522.5 523.6 566.6 627.0 647.7 653.3 670.0 7576.5 7767.3 7790.8 7969.8 8027.2 609.4 625.3 630.8 639.0 645.5 3706.3 3822.0 3836.3 3955.3 3998.5 39880.4 43169.8 43362.8 43382.6 43452.8 37233.3 38986.4 39399.0 39633.2 42523.6 38007.8 38080.6 38435.0 38861.0 40427.2 7652.3 7847.6 8138.2 8220.8 8245.1 23519.5 26015.5 26206.5 26497.7 26981.7 33468.2 35350.5 36549.7 36976.4 37427.1 9592.8 9659.5 9718.9 9893.4 9908.2 11271.6 11356.7 11392.5 11609.9 11666.2 10594.2 10710.5 10769.1 10844.9 11183.3 11268.6 11323.4 11415.9 11899.0 11973.3 10713.8 11068.9 11079.6 11225.7 11619.1 9276.8 9422.2 9567.2 9589.4 9670.1 9288.3 9353.3 9389.0 9398.3 9399.3 22:42:17 INFO - PROCESS | 3393 | -------- Summary: end -------- 22:42:17 INFO - PROCESS | 3393 | 22:42:18 INFO - TEST-INFO | 3393: exit 0 22:42:18 INFO - TEST-OK | dromaeo_css | took 1119563ms 22:42:18 INFO - TEST-START | kraken 22:42:18 INFO - operating with platform_type : linux_ 22:42:18 INFO - Initialising browser for kraken test... 22:42:18 INFO - TEST-INFO | started process 3571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7bDkoR/profile http://localhost:57007/getInfo.html) 22:42:22 INFO - PROCESS | 3571 | __metrics Screen width/height:1600/1200 22:42:22 INFO - PROCESS | 3571 | colorDepth:24 22:42:22 INFO - PROCESS | 3571 | Browser inner width/height: 1024/697 22:42:22 INFO - PROCESS | 3571 | __metrics 22:42:23 ERROR - PROCESS | 3571 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:42:24 INFO - TEST-INFO | 3571: exit 0 22:42:24 INFO - Browser initialized. 22:42:24 INFO - Running cycle 1/1 for kraken test... 22:42:24 INFO - TEST-INFO | started process 3654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7bDkoR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:36 INFO - PROCESS | 3654 | RSS: Main: 155238400 22:42:36 INFO - PROCESS | 3654 | 22:42:39 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57007/tests/kraken/driver.html?testName=audio-beat-detection) 22:42:40 INFO - PROCESS | 3654 | RSS: Main: 210321408 22:42:40 INFO - PROCESS | 3654 | 22:42:43 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57007/tests/kraken/driver.html?testName=audio-dft) 22:42:43 INFO - PROCESS | 3654 | RSS: Main: 196108288 22:42:43 INFO - PROCESS | 3654 | 22:42:46 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57007/tests/kraken/driver.html?testName=audio-fft) 22:42:47 INFO - PROCESS | 3654 | RSS: Main: 266600448 22:42:47 INFO - PROCESS | 3654 | 22:42:49 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57007/tests/kraken/driver.html?testName=audio-oscillator) 22:42:50 INFO - PROCESS | 3654 | RSS: Main: 174784512 22:42:50 INFO - PROCESS | 3654 | 22:42:52 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:53 INFO - PROCESS | 3654 | RSS: Main: 178589696 22:42:53 INFO - PROCESS | 3654 | 22:42:56 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57007/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:56 INFO - PROCESS | 3654 | RSS: Main: 215207936 22:42:56 INFO - PROCESS | 3654 | 22:43:00 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57007/tests/kraken/driver.html?testName=imaging-desaturate) 22:43:00 INFO - PROCESS | 3654 | RSS: Main: 215580672 22:43:00 INFO - PROCESS | 3654 | 22:43:03 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57007/tests/kraken/driver.html?testName=json-parse-financial) 22:43:04 INFO - PROCESS | 3654 | RSS: Main: 215740416 22:43:04 INFO - PROCESS | 3654 | 22:43:06 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:43:06 INFO - PROCESS | 3654 | RSS: Main: 202690560 22:43:06 INFO - PROCESS | 3654 | 22:43:08 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:43:09 INFO - PROCESS | 3654 | RSS: Main: 205467648 22:43:09 INFO - PROCESS | 3654 | 22:43:11 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:43:12 INFO - PROCESS | 3654 | RSS: Main: 220241920 22:43:12 INFO - PROCESS | 3654 | 22:43:14 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:43:15 INFO - PROCESS | 3654 | RSS: Main: 225136640 22:43:15 INFO - PROCESS | 3654 | 22:43:18 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:43:19 INFO - PROCESS | 3654 | RSS: Main: 219570176 22:43:19 INFO - PROCESS | 3654 | 22:43:20 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:57007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57007/tests/kraken/driver.html?testName=ai-astar) 22:43:21 INFO - PROCESS | 3654 | RSS: Main: 282116096 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | __start_tp_report 22:43:21 INFO - PROCESS | 3654 | _x_x_mozilla_page_load 22:43:21 INFO - PROCESS | 3654 | _x_x_mozilla_page_load_details 22:43:21 INFO - PROCESS | 3654 | |i|pagename|runs| 22:43:21 INFO - PROCESS | 3654 | |0;ai-astar;112;113;109;115;113;112;102;112;113;113 22:43:21 INFO - PROCESS | 3654 | |1;audio-beat-detection;163;132;156;184;133;159;156;133;183;143 22:43:21 INFO - PROCESS | 3654 | |2;audio-dft;160;161;161;162;162;162;162;159;162;159 22:43:21 INFO - PROCESS | 3654 | |3;audio-fft;74;73;97;108;77;74;72;114;98;75 22:43:21 INFO - PROCESS | 3654 | |4;audio-oscillator;94;94;148;94;94;93;145;93;94;141 22:43:21 INFO - PROCESS | 3654 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;116;117 22:43:21 INFO - PROCESS | 3654 | |6;imaging-darkroom;146;146;146;146;146;145;145;145;145;146 22:43:21 INFO - PROCESS | 3654 | |7;imaging-desaturate;94;97;94;95;95;95;95;95;95;94 22:43:21 INFO - PROCESS | 3654 | |8;json-parse-financial;64;64;62;63;63;63;63;87;62;61 22:43:21 INFO - PROCESS | 3654 | |9;json-stringify-tinderbox;64;65;64;63;64;64;64;65;63;64 22:43:21 INFO - PROCESS | 3654 | |10;stanford-crypto-aes;87;81;79;78;80;81;89;79;81;80 22:43:21 INFO - PROCESS | 3654 | |11;stanford-crypto-ccm;136;141;141;132;138;132;142;142;170;140 22:43:21 INFO - PROCESS | 3654 | |12;stanford-crypto-pbkdf2;183;185;177;185;188;182;177;179;178;183 22:43:21 INFO - PROCESS | 3654 | |13;stanford-crypto-sha256-iterative;74;73;72;72;74;73;74;72;77;71 22:43:21 INFO - PROCESS | 3654 | __end_tp_report 22:43:21 INFO - PROCESS | 3654 | __start_cc_report 22:43:21 INFO - PROCESS | 3654 | _x_x_mozilla_cycle_collect,1883 22:43:21 INFO - PROCESS | 3654 | __end_cc_report 22:43:21 INFO - PROCESS | 3654 | __startTimestamp1461217401082__endTimestamp 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | ------- Summary: start ------- 22:43:21 INFO - PROCESS | 3654 | Number of tests: 14 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.63 (3.2%) stddev-sans-first:3.84 22:43:21 INFO - PROCESS | 3654 | Values: 112.0 113.0 109.0 115.0 113.0 112.0 102.0 112.0 113.0 113.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:157.50 stddev:19.27 (12.2%) stddev-sans-first:20.17 22:43:21 INFO - PROCESS | 3654 | Values: 163.0 132.0 156.0 184.0 133.0 159.0 156.0 133.0 183.0 143.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 22:43:21 INFO - PROCESS | 3654 | Values: 160.0 161.0 161.0 162.0 162.0 162.0 162.0 159.0 162.0 159.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#3] audio-fft Cycles:10 Average:86.20 Median:74.50 stddev:16.29 (21.9%) stddev-sans-first:16.67 22:43:21 INFO - PROCESS | 3654 | Values: 74.0 73.0 97.0 108.0 77.0 74.0 72.0 114.0 98.0 75.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:24.67 (26.2%) stddev-sans-first:25.56 22:43:21 INFO - PROCESS | 3654 | Values: 94.0 94.0 148.0 94.0 94.0 93.0 145.0 93.0 94.0 141.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:43:21 INFO - PROCESS | 3654 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:43:21 INFO - PROCESS | 3654 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 22:43:21 INFO - PROCESS | 3654 | Values: 94.0 97.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:63.00 stddev:7.71 (12.2%) stddev-sans-first:8.17 22:43:21 INFO - PROCESS | 3654 | Values: 64.0 64.0 62.0 63.0 63.0 63.0 63.0 87.0 62.0 61.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:43:21 INFO - PROCESS | 3654 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 64.0 65.0 63.0 64.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:3.60 (4.4%) stddev-sans-first:3.22 22:43:21 INFO - PROCESS | 3654 | Values: 87.0 81.0 79.0 78.0 80.0 81.0 89.0 79.0 81.0 80.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:141.00 stddev:10.74 (7.6%) stddev-sans-first:11.21 22:43:21 INFO - PROCESS | 3654 | Values: 136.0 141.0 141.0 132.0 138.0 132.0 142.0 142.0 170.0 140.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:183.00 stddev:3.80 (2.1%) stddev-sans-first:4.00 22:43:21 INFO - PROCESS | 3654 | Values: 183.0 185.0 177.0 185.0 188.0 182.0 177.0 179.0 178.0 183.0 22:43:21 INFO - PROCESS | 3654 | 22:43:21 INFO - PROCESS | 3654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.50 stddev:1.69 (2.3%) stddev-sans-first:1.76 22:43:21 INFO - PROCESS | 3654 | Values: 74.0 73.0 72.0 72.0 74.0 73.0 74.0 72.0 77.0 71.0 22:43:21 INFO - PROCESS | 3654 | -------- Summary: end -------- 22:43:21 INFO - PROCESS | 3654 | 22:43:22 INFO - TEST-INFO | 3654: exit 0 22:43:22 INFO - TEST-OK | kraken | took 63646ms 22:43:22 INFO - SUITE-END | took 1183s 22:43:22 INFO - Completed test suite (00:19:43) 22:43:22 INFO - javascript benchmark 22:43:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2551.5534781413253, 2616.2020583721956, 2630.395009147896, 2633.947321053578, 2651.9999999999995, 4431.0, 4513.165064463076, 4563.2470642344015, 4601.815927362902, 4609.0781843631285, 4558.566936141069, 4591.793369298382, 4612.146752850725, 4674.7428891410955, 4679.719216846992, 4208.97895510522, 4214.178235244129, 4244.427002354689, 4269.274223382017, 4362.650987920959, 4256.404103425508, 4320.740755554677, 4330.545292744264, 4338.522762496123, 4372.89067773305, 4100.979495102535, 4163.459519977628, 4247.766372849492, 4260.68044896634, 4344.782760861945, 4239.512456067561, 4260.659147268211, 4264.275073237557, 4264.552222016675, 4315.6763242756915, 4252.383404406375, 4255.0426154115385, 4259.8509052183335, 4280.59334363235, 4281.807318670636, 4352.7823608819745, 4495.685302028859, 4517.028838799673, 4560.680752347337, 4579.358889755437, 4885.7312847793355, 4901.191303434929, 4901.313816065754, 4901.387326584177, 4930.778114984834, 4803.543663351976, 4947.307376967227, 4953.554180123806, 4953.653244272902, 4996.100701873661, 4588.0365123324145, 4635.559621835921, 4646.3495110684535, 4650.906981860344, 4663.906721865544, 4961.950380496149, 4982.252662100714, 4989.0, 4996.100701873697, 5029.7736601853, 4786.1863483207935, 4795.184818580849, 4797.2564252540915, 4809.278608208797, 4848.10310092634, 4756.21522448799, 4866.489018653061, 4927.7536123193695, 4952.0, 4955.40535135786, 4899.559039686445, 4906.484819094015, 4913.533214344631, 4916.360873086547, 4969.0310389474425, 4882.536159064884, 4894.241392584155, 4902.41171059468, 4909.558139767438, 4964.528369804862, 3946.5856085111222, 3988.980055099706, 4017.015831121394, 4025.698072644505, 4028.798560071985, 3584.8566057357934, 3587.6053634100226, 3615.8192090395373, 3615.837287322077, 3647.3434781739543, 4248.511421186541, 4248.575142485726, 4252.149570085933, 4287.485501739811, 4290.442242508454, 4731.881702957454, 4856.125897338442, 4858.368412106474, 4871.0, 4927.482614325516, 4316.719413238129, 4324.200022995756, 4330.978345108254, 4343.391925130484, 4349.565043495689, 4410.713303635253, 4441.133978874089, 4454.198244316054, 4456.197884380843, 4493.326001099861, 4567.086582683411, 4706.882327941828, 4747.952520474889, 4754.477007529169, 4759.619230461485, 4881.780319885543, 4891.657583969088, 4894.828680996148, 4897.657163998486, 4914.311996320446, 4636.142313671981, 4663.976680116578, 4681.625469962463, 4685.344051832814, 4719.3628860103445, 4675.368825208553, 4860.635452341018, 4875.561199492063, 4925.581325587222, 4937.9259311109645, 4940.802367905388, 4946.183879659816, 4958.231474121517, 4958.826441074545, 5011.874703132451, 4800.783964721666, 4826.251930950708, 4830.058138662927, 4839.056384005085, 4860.756962151808, 4653.302004699322, 4780.521947805191, 4826.58973987215, 4828.734419606815, 4833.73414462208, 4663.743494107856, 4677.2750223715375, 4684.672072954861, 4685.344051832814, 4731.172044892061, 4746.5490778376, 4784.593309568726, 4787.18617834962, 4792.7124372537755, 4848.7090774553635, 4671.85984420468, 4705.717656940595, 4732.124556956974, 4764.952350476451, 4778.832740854054], "value": 4517.873116939655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1241045353569, 593.8040446652606, 595.431363048289, 605.6759633596024, 606.9696515174246, 26326.34184145395, 33171.66828331716, 34092.318153636916, 34171.658283417186, 34326.65673343266, 36464.81767591158, 37092.0, 37201.255974880485, 37232.44151337732, 37242.8137859311, 7451.254874512546, 7594.430417718693, 7610.695572177106, 7623.161452240249, 7629.961850190742, 7338.706451741924, 7417.072865891763, 7440.0, 7447.590382528959, 7641.7707468776025, 7609.619519024054, 7645.655945482466, 7646.770596882075, 7646.961765191167, 7650.540967541938, 7564.130125035609, 7615.16233214346, 7635.580043097628, 7642.617869106522, 7642.7325043623205, 7741.496802707806, 7844.646990885367, 7849.764507064797, 7851.489653172525, 7856.567888766115, 37038.0, 37516.0, 37549.249015019544, 37570.812145939366, 37590.62409375898, 3009.9849500752575, 3190.7287880530184, 3396.7961922284494, 3729.4032954727113, 3798.1074447504816, 25958.480830383476, 25974.610380844304, 27455.45089098207, 29297.56053659197, 30062.54906176409, 3509.4209455439823, 3513.402721537345, 3531.170175008871, 3620.348337299285, 3735.794531300777, 167673.0, 168112.0, 168336.1583192076, 168464.0, 169234.0, 32410.83794581012, 33281.167970800925, 49622.50377496251, 50437.0, 50536.0, 31669.52495712566, 31761.841190793897, 31791.18505779275, 31847.363052739278, 31883.681163188536, 12165.75668486643, 12379.75240495203, 12381.504739810307, 12399.504019839285, 12408.875911240953, 9936.453495057696, 10000.849987250198, 10005.79988400228, 10011.79976400468, 10013.49932503372, 8098.797530061795, 8112.391570632226, 8152.796180095545, 8191.631376588068, 8220.177982201732, 3165.7625678074237, 3195.2331440454122, 3199.856006479714, 3203.951940720891, 3231.919202019921, 836.1763662792144, 846.9449485783405, 877.2762470961483, 877.7542288159326, 912.780932576177, 27423.725762742117, 28177.0, 28735.712642873303, 28756.856215718788, 28757.56863647047, 963.7253382785873, 1012.119456073221, 1050.0, 1060.7295139739317, 1101.2951710905027, 15028.699426011419, 15144.621384465256, 15162.772558411632, 15256.618584535254, 15300.699440547456, 336749.0, 341205.0, 342615.0, 343305.0, 344560.0, 46700.06599868052, 47554.28668569974, 47629.28556071662, 47676.523234767905, 47751.0, 983.1004630762772, 1023.9641612543675, 1099.4118146791589, 1187.4656404617956, 1218.823270625772, 25306.493870122125, 25805.870970645028, 26342.0, 26470.470590588466, 26699.866500668148, 36247.45628815517, 36470.0, 36834.0, 36862.44706329353, 36863.262734745695, 186494.2025869586, 187400.0, 188311.0, 188607.0, 189086.0, 22130.778692212873, 23900.0, 24665.876670616533, 25196.87401563054, 25313.620295695946, 36048.03471618067, 36293.27413451769, 36345.454818178274, 36879.81560092182, 37292.440613391365, 33604.663953360156, 33805.492917606745, 34174.31651366909, 34293.0, 34384.82807586046, 33168.668313317525, 33799.0, 33947.49078763771, 34127.488087678204, 34135.65864341325, 35196.648033519334, 35457.64542354544, 36164.4575331365, 36394.27211455703, 36714.26571468609, 26357.604635930093, 28964.565531516622, 28985.0, 29098.272543185743, 29175.124746257647, 23108.306750797503, 23127.537449251256, 23570.0, 24433.75566244315, 24606.630900536147], "value": 15386.008795785276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.59704533876726, 361.47586000299566, 364.4151137424435, 377.9508663873696, 379.11098474078295, 15778.447754328601, 16251.674966500663, 16587.087710175965, 16641.41755038574, 16675.166241687926, 14560.490382836602, 16545.338186472556, 16657.83342166578, 16860.0, 16861.40985065523, 4849.806007759694, 5091.363579552556, 5113.488651134875, 5129.897402051956, 5140.074786538422, 3630.8366123524374, 5045.772940217681, 5489.890202195954, 5788.47903688668, 5818.0981947798155, 5737.913931291034, 5742.196092547047, 5761.510271626917, 5763.020286551276, 5773.971130144343, 5587.1339942309005, 5668.31980162379, 5724.341700704431, 5725.198472213893, 5756.942430575725, 3302.5871766029245, 4750.168720473903, 5000.449950505442, 5010.448850626428, 5015.473375295578, 18898.52753681155, 19245.615087698166, 19310.903445482683, 20276.493087672778, 20303.89848050765, 1866.925322987079, 1890.6880364739802, 1967.3606078024557, 2225.4436390902274, 2537.949241015188, 12864.549740759123, 13079.28063956482, 13184.472621095145, 13381.330933453288, 13602.31988400576, 1705.7782488276569, 1734.2802736864187, 1814.639020734449, 1867.5891303913118, 1883.4632129842928, 60532.39467605312, 60855.39144608586, 61647.07529387063, 62938.0559291611, 63420.0, 9053.547322633842, 9130.31522635805, 9327.860082098774, 9679.886813016594, 9693.563789629483, 12898.67753306175, 12930.870691293156, 12945.805812912813, 12969.805452918214, 12985.636508166506, 6993.0908981832035, 7018.368346848706, 7136.964315178391, 7206.243344448862, 7223.1693355264815, 6784.59292442455, 6873.621950792654, 6945.548539344926, 6953.443724502028, 6958.617276049765, 5969.462748352582, 6048.637081775108, 6083.11794789753, 6108.816735497942, 6118.969405152946, 1532.494276888624, 1650.6698660267994, 1655.908925009112, 1667.7831881855282, 1683.5706894741763, 846.9068402475723, 848.5248260973874, 860.4966094834592, 860.8837806896114, 919.0671468459519, 16473.6705265894, 17263.3957811476, 17306.134693265285, 17812.287508499776, 18126.63746725058, 874.7594411536751, 885.9468431894107, 889.2841262783521, 905.8777065096259, 936.9672061477816, 9820.165285950632, 9882.308238423242, 10140.797184056277, 10148.797024059477, 10195.592176312864, 376475.0, 387112.0, 395172.0, 395814.0, 398221.0, 72238.63880680563, 73104.63447682835, 73813.0, 73874.0, 74123.0, 948.5684013773716, 949.3923888711369, 969.1132613658424, 987.5457289646843, 989.7426669065951, 15531.22343882824, 15743.527694169194, 15754.684906302038, 15871.2064396782, 16152.67694646077, 30619.846900765355, 31933.0, 32575.674243257265, 32735.83632081824, 33777.0, 45930.54069459396, 46238.30642540432, 46633.76683116562, 47123.29315060208, 47197.29204061873, 7510.57443710308, 7524.473286869867, 7695.461317707706, 7784.987951566261, 7807.765767026998, 11957.043436525231, 12050.397480126134, 12161.33112678811, 12180.695482613006, 12303.93848030754, 10545.261831672016, 10671.413072281099, 10712.625058122929, 11061.723456913642, 11079.83380249313, 10522.368657880552, 10540.472976351306, 10638.680839574825, 10709.357438553712, 10824.783504330027, 10812.729681758019, 10849.566017359533, 10889.128869690247, 11010.0, 11171.273867198606, 7434.584244311904, 7462.403007759474, 7478.925210748041, 7583.544987300779, 7776.222377762178, 9492.525373731423, 10060.245481588763, 10084.596616135566, 10310.587576497157, 10838.403887786248], "value": 8283.044562435984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.6305108467457, 1423.1390009044524, 1462.8902832287579, 1581.8418158184184, 1763.4357005758154, 7366.152892417374, 7688.038995125609, 7701.884471732915, 7710.344620707233, 7714.421418393622, 7503.699852005913, 7637.579933103677, 7651.387888968883, 7655.808604784883, 7658.92341076589, 1827.3147569661378, 2164.632012557869, 2182.0, 2191.824654027674, 2252.650839119939, 2255.221948427798, 2268.296827983322, 2280.395695140789, 2285.8171346292256, 2285.908563657452, 2205.283282933045, 2252.6621006849023, 2253.876036817974, 2254.2786308381324, 2255.154317131076, 1890.395073576456, 2088.6553718636483, 2141.453929248047, 2143.517708515587, 2147.7315335583053, 2172.424307558498, 2188.912443502258, 2195.3633446300555, 2196.967045494319, 2201.680756290345, 7685.154632990367, 7709.2290770922455, 7745.496542724705, 7754.0, 7759.2628700273945, 4301.505326887417, 4425.491068527129, 4427.822887084512, 4447.1995040892625, 4491.865244042684, 2943.396603696237, 2960.955585666217, 2963.4517614241436, 2963.881444742208, 3038.2404398900276, 973.8101070291297, 991.6826615483048, 996.940183588987, 1004.5780772075673, 1011.4133802394593, 10426.687199384107, 10430.843537346946, 10452.16382689383, 10465.9476702616, 10469.84295235572, 4137.8965525861495, 4176.206520761046, 4292.0, 4344.956550434518, 4421.46942366918, 8060.516369017878, 8062.879056814152, 8105.75682729519, 8137.064237612632, 8150.9184908150155, 4017.8995525112105, 4487.708298960557, 4501.054778496552, 4515.119551687455, 4522.592966632953, 3794.6395092466723, 3826.7895265760094, 3828.2917660232947, 3832.0419895026243, 4184.790760461965, 3435.3301106284534, 3440.587129544421, 3547.6629720176543, 3576.2668652926086, 3579.8926032219074, 1032.8450732390202, 1092.1317552545745, 1093.4532733633184, 1101.0475938313302, 1110.6168371911679, 852.9232369086687, 862.2498426369099, 862.5256109139948, 899.9775005624781, 907.6687009241712, 5476.863078423071, 5565.582581306418, 5574.9721251393485, 5784.161296611967, 5820.388859169726, 897.6499165325529, 927.6196759328777, 936.9200375167118, 939.1406862720535, 953.6614501851882, 3600.8199590020395, 3625.274945011008, 3729.1050147964293, 3760.567534733486, 3842.366009608383, 9305.25557955362, 9653.22774178064, 9691.176250018687, 9729.708108756608, 9739.366941148803, 9555.474448905377, 9596.18432433251, 9599.32804703664, 9622.566984485715, 9646.421214727, 6876.518643694893, 7094.290570942864, 7188.5327453715345, 7188.748393806191, 7228.963855180796, 5343.4389389113585, 5483.396826349019, 5488.670679759227, 5507.614466987273, 5613.0, 8761.5181165034, 8796.560171991503, 8868.86696699537, 8872.512011839412, 8893.288536916902, 8445.831083378174, 8581.227689507974, 8672.0, 8791.648334066565, 8798.868016979623, 6151.384861513813, 6636.668166591555, 6666.799996000128, 6873.072135261676, 6873.862522749417, 7419.777406677808, 7432.925670743223, 7476.4018878488505, 7493.812654683677, 7510.511816731895, 6598.076269322202, 6739.5619284746335, 6768.593884366954, 6830.282820303995, 6926.168859736864, 6682.665866706742, 6756.256811750802, 6793.558418702769, 6859.211190713132, 6865.41643960249, 6183.81448556544, 6313.526485513697, 6361.332060133805, 6369.1401660777055, 6375.713092910923, 4728.574428301469, 4753.857384278477, 4789.353437285922, 4799.880002999953, 4836.93587410769, 4818.38584074339, 4849.127157111754, 4888.31563581106, 4905.23968784839, 4915.582175515121], "value": 4140.8808521359915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.43712413473, 303.6356372353177, 305.11060259344015, 317.61727118821824, 317.91416317594235, 4999.950000499994, 5013.273075404064, 5034.144195486767, 5034.295198672189, 5063.341765570471, 4945.6043516518685, 4948.430930443, 4966.70199788013, 4976.825811096613, 4978.477259887714, 3688.5942546319884, 3744.4383342498572, 3926.5877082906313, 3928.9803550982206, 3945.329294020009, 3873.6513713765758, 3917.804109794499, 3922.2743792398355, 3929.0963078491964, 3939.1727737175083, 3618.8190590470504, 3885.805709714517, 3895.61043895611, 3906.5898080701545, 3908.257431088098, 3753.2868754936476, 3881.6312450317314, 3883.2233553289457, 3903.6291552302487, 3905.0, 3419.777714448553, 3439.2777516721517, 3446.8104254266004, 3451.706604938558, 3454.6199918008997, 4761.8095276188915, 4764.547368000034, 4765.952340476586, 4769.76151192439, 4798.49615790344, 4312.547182545819, 4453.933191002137, 4464.754438505881, 4473.105378924196, 4491.124230774967, 5177.974110129463, 5195.402528709209, 5207.4011488678525, 5211.1922651989, 5224.63427560071, 3766.9058273543105, 3769.2838360711376, 3773.6981041516615, 3779.848806047755, 3791.905202369935, 5257.185136303879, 5443.237946687467, 5457.727113644302, 5476.972615136939, 5477.7261136943, 3836.8848934532007, 3851.7496362736892, 3861.2470568239487, 3864.1112544115012, 3868.709846761504, 3926.096997690547, 3926.6858651307825, 3933.586973367755, 3933.9016524587114, 3936.3701807710627, 4443.089166720814, 4444.533324000933, 4447.666425018137, 4452.621527170227, 4453.487848897418, 4883.658143929962, 5137.306463627362, 5158.561522270649, 5194.35070616173, 5203.453637368098, 1307.4508706343358, 1329.0497294434526, 1329.654289884637, 1329.9468021279233, 1334.6463187255385, 839.8446287436843, 871.949301092195, 884.6284560484612, 886.5655828644047, 907.5054095517827, 4625.537446255347, 4656.95343046572, 4661.3707149534375, 4673.836415725501, 4680.625549955996, 5322.350071477854, 5333.599980001438, 5335.786568537293, 5339.092354299778, 5340.145576707708, 4483.103379324149, 4586.495485496593, 4593.242115050979, 4614.861554153314, 4632.0, 2819.7039310872474, 2841.5169421198448, 2843.061789609424, 2849.2734352739917, 2853.0, 5076.847694569169, 5088.898222035613, 5091.261767043758, 5093.490650934951, 5097.439281679012, 5283.577313814885, 5463.2078348639225, 5463.9072185563045, 5465.480779326037, 5488.451154884559, 5041.924371134436, 5070.366204224472, 5072.15959062926, 5073.619478539124, 5099.923501147486, 5288.4182739897815, 5293.179557168491, 5312.229726689531, 5313.0, 5333.813316533902, 5021.7740201690285, 5199.610029247897, 5219.347581552306, 5226.4581948326095, 5229.843104706865, 5056.266841307916, 5059.519345662156, 5059.949400506095, 5068.113080211022, 5075.543201111917, 3749.775013499199, 3755.310110450363, 3757.1170774868433, 3770.792606406674, 3772.905677358088, 5198.116320225647, 5241.240020197126, 5304.363476382859, 5314.415414304346, 5325.547328477122, 5142.820001299937, 5151.2273159026445, 5156.329677141947, 5164.9741751291, 5170.7156106413, 5159.458256882973, 5164.586833053271, 5167.328247327823, 5170.560502357342, 5177.249298851721, 4926.531979461945, 5087.694738315713, 5149.176131818891, 5187.896242075213, 5206.167013278009, 5029.497050294941, 5116.334876466036, 5242.423333433396, 5274.0, 5324.121519949165, 5186.870328241824, 5189.818356357509, 5191.480851914929, 5203.580335144176, 5208.869778255423], "value": 3929.8592481289143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.6848284030765, 706.2266817834469, 722.6820199112391, 786.6931896560343, 788.8027993001749, 10843.891561084387, 11278.266912650683, 11480.081593472523, 11484.966353028225, 11505.0, 11621.360825154614, 11664.475098620562, 11695.941520292386, 11698.590549330775, 11705.3562054087, 621.8258887511504, 763.526613499631, 781.0432220529848, 789.4237206839011, 795.9084705258882, 785.8781888807215, 786.1941509952316, 790.8220650353682, 792.0, 792.1642666986327, 819.4468733604793, 823.9711610093648, 824.0194168938973, 824.6206744897354, 824.9505029698207, 656.9441597464221, 812.8821320908494, 831.6922738586761, 831.9500829950223, 831.9916800831975, 612.185792895448, 612.2683393344954, 612.3386742318286, 612.4059662127729, 612.9049997250434, 11290.983811456927, 11316.943415282953, 11379.0, 11392.94303528477, 11432.657020289405, 11472.369019703912, 11789.882101178964, 11799.646010619696, 12032.27806331623, 12102.576409825613, 9445.52772361386, 9657.565409556586, 9750.268729845218, 9843.950780246125, 9961.501924903798, 3194.853233632964, 3199.392115498048, 3258.201740573551, 3268.084936217863, 3294.439945209296, 43016.784916075216, 43266.13467730659, 43396.34905476389, 43813.56186438127, 44906.10187796258, 9188.26493880488, 9250.4912229828, 9296.8605470918, 9363.391379560308, 9406.153446189875, 14778.778318325234, 15587.688246235011, 15601.765973510406, 15625.453109141126, 15638.3744650215, 6772.932270677329, 6871.347222013901, 6920.169579650475, 6964.4428445724225, 6970.128733908262, 3497.667721566447, 3576.2311103112434, 3625.6374362563533, 3647.252313275825, 3744.962550374516, 2680.32991752062, 2745.3136715821047, 2746.8489233092373, 2761.295869553251, 2767.2805070681766, 463.36518969011996, 480.0590841949817, 508.01952232191485, 522.4931816138339, 523.5706720489162, 566.5892228134652, 626.9655168965751, 647.6923461355913, 653.3401264722569, 669.9531032827753, 7576.475044985351, 7767.300942915164, 7790.79297179528, 7969.8406031880195, 8027.197280272043, 609.3936533149545, 625.3465128940269, 630.7673174978237, 639.0, 645.4642646603402, 3706.258748250361, 3822.025383527183, 3836.290286297044, 3955.2880481513603, 3998.520177578651, 39880.41674165619, 43169.784151079046, 43362.78318608387, 43382.566174338484, 43452.78273608612, 37233.25533489315, 38986.41520377197, 39399.0, 39633.20733585312, 42523.57476425258, 38007.80996095002, 38080.61919380826, 38434.99999999944, 38861.0, 40427.1914561713, 7652.311291983749, 7847.568383738949, 8138.186181381814, 8220.83558328842, 8245.093039765741, 23519.52960940806, 26015.479690406464, 26206.475870482103, 26497.735022649525, 26981.73018269792, 33468.163295917795, 35350.46974295336, 36549.71052605278, 36976.445353319185, 37427.064323391045, 9592.808143837225, 9659.46872921996, 9718.9028109718, 9893.35693179941, 9908.207343412654, 11271.605493808005, 11356.716082098013, 11392.48733806964, 11609.88390116088, 11666.241694289844, 10594.20543459259, 10710.518026688662, 10769.13846892231, 10844.891551084704, 11183.273087249303, 11268.605598804003, 11323.377214252965, 11415.942920285677, 11899.0, 11973.281603103842, 10713.785724285315, 11068.944655276671, 11079.5568177272, 11225.719357015812, 11619.128565357463, 9276.768080798034, 9422.19911307519, 9567.234621230424, 9589.42463452195, 9670.129688328085, 9288.34981551285, 9353.345265831327, 9388.95305523468, 9398.2951278653, 9399.295052871199], "value": 5710.346865269345, "unit": "score"}], "name": "dromaeo_css", "value": 6138.623427042338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 109.0, 115.0, 113.0, 112.0, 102.0, 112.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 156.0, 184.0, 133.0, 159.0, 156.0, 133.0, 183.0, 143.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 159.0, 162.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 97.0, 108.0, 77.0, 74.0, 72.0, 114.0, 98.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 148.0, 94.0, 94.0, 93.0, 145.0, 93.0, 94.0, 141.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 87.0, 62.0, 61.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 79.0, 78.0, 80.0, 81.0, 89.0, 79.0, 81.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 141.0, 132.0, 138.0, 132.0, 142.0, 142.0, 170.0, 140.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 177.0, 185.0, 188.0, 182.0, 177.0, 179.0, 178.0, 183.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 72.0, 74.0, 73.0, 74.0, 72.0, 77.0, 71.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1586.0000000000002, "alertThreshold": 2.0}]} 22:43:22 INFO - Return code: 0 22:43:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:43:22 ERROR - # TBPL SUCCESS # 22:43:22 INFO - Running post-action listener: _resource_record_post_action 22:43:22 INFO - Running post-run listener: _resource_record_post_run 22:43:23 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7663616; Write bytes: 480907264; Read time: 956; Write time: 371748 22:43:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 161173504; Read time: 0; Write time: 100292 22:43:23 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5902336; Write bytes: 319733760; Read time: 900; Write time: 271456 22:43:23 INFO - Running post-run listener: _upload_blobber_files 22:43:23 INFO - Blob upload gear active. 22:43:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:43:23 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 22:43:23 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'] 22:43:23 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 22:43:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:24 INFO - (blobuploader) - INFO - Done attempting. 22:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:25 INFO - (blobuploader) - INFO - Done attempting. 22:43:25 INFO - (blobuploader) - INFO - Iteration through files over. 22:43:25 INFO - Return code: 0 22:43:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:43:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:43:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b270f91b887fa3982e41fd6bd466753bfedb525b7ba00f9dc45006b7617c49d1dc4a82b55df36e2507c87f5abaf3f546e8f5f6385663107fe852916c6ed12094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f23670acdcc71266605b67dfcbe712cee66d3635c10de5dea7aaa246070199dbd1ac33be1a58db30ec200c5f696d5659a75543d1447d09ce268ae0ad92b5f2c"} 22:43:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:43:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:43:25 INFO - Contents: 22:43:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b270f91b887fa3982e41fd6bd466753bfedb525b7ba00f9dc45006b7617c49d1dc4a82b55df36e2507c87f5abaf3f546e8f5f6385663107fe852916c6ed12094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f23670acdcc71266605b67dfcbe712cee66d3635c10de5dea7aaa246070199dbd1ac33be1a58db30ec200c5f696d5659a75543d1447d09ce268ae0ad92b5f2c"} 22:43:25 INFO - Running post-run listener: copy_logs_to_upload_dir 22:43:25 INFO - Copying logs to upload dir... 22:43:25 INFO - mkdir: /builds/slave/test/build/upload/logs 22:43:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.365035 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-20 22:43:25.432782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:43:25.436465) ========= 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=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b270f91b887fa3982e41fd6bd466753bfedb525b7ba00f9dc45006b7617c49d1dc4a82b55df36e2507c87f5abaf3f546e8f5f6385663107fe852916c6ed12094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f23670acdcc71266605b67dfcbe712cee66d3635c10de5dea7aaa246070199dbd1ac33be1a58db30ec200c5f696d5659a75543d1447d09ce268ae0ad92b5f2c"} build_url:https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011073 build_url: 'https://queue.taskcluster.net/v1/task/fy8GDjf-QLaClx6oG9xtxg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b270f91b887fa3982e41fd6bd466753bfedb525b7ba00f9dc45006b7617c49d1dc4a82b55df36e2507c87f5abaf3f546e8f5f6385663107fe852916c6ed12094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f23670acdcc71266605b67dfcbe712cee66d3635c10de5dea7aaa246070199dbd1ac33be1a58db30ec200c5f696d5659a75543d1447d09ce268ae0ad92b5f2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:43:25.461271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:43:25.461608) ========= 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=4300f881736b422476174874000001bc-1461211724.765807-1510309866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:43:25.545436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:43:25.545752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:43:25.546049) ========= ========= Total master_lag: 0.18 =========