builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1461330501.64 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.636745) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.637315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.637595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.653837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.654166) ========= 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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:08:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-22 06:08:22 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.790407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.790733) ========= 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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.843345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:21.843728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --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 d42b25947fc26a0f9eab98d631465b72769553bd --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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:08:22,114 truncating revision to first 12 chars 2016-04-22 06:08:22,114 Setting DEBUG logging. 2016-04-22 06:08:22,114 attempt 1/10 2016-04-22 06:08:22,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:08:22,395 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:22.417246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:22.417572) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:22.418027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:22.418445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:22.427380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:08:22.427696) ========= /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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:08:22 INFO - MultiFileLogger online at 20160422 06:08:22 in /builds/slave/test 06:08:22 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 06:08:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:22 INFO - {'append_to_log': False, 06:08:22 INFO - 'base_work_dir': '/builds/slave/test', 06:08:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:08:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:22 INFO - 'branch': 'Fx-Team-Non-PGO', 06:08:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:22 INFO - 'config_files': ('talos/linux_config.py',), 06:08:22 INFO - 'default_actions': ('clobber', 06:08:22 INFO - 'read-buildbot-config', 06:08:22 INFO - 'download-and-extract', 06:08:22 INFO - 'populate-webroot', 06:08:22 INFO - 'create-virtualenv', 06:08:22 INFO - 'install', 06:08:22 INFO - 'run-tests'), 06:08:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:22 INFO - 'download_minidump_stackwalk': True, 06:08:22 INFO - 'download_symbols': 'ondemand', 06:08:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:22 INFO - 'installer_path': 'installer.exe', 06:08:22 INFO - 'log_level': 'info', 06:08:22 INFO - 'log_name': 'talos', 06:08:22 INFO - 'log_to_console': True, 06:08:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:08:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:08:22 INFO - 'opt_config_files': (), 06:08:22 INFO - 'pip_index': False, 06:08:22 INFO - 'sps_profile': False, 06:08:22 INFO - 'sps_profile_interval': 0, 06:08:22 INFO - 'suite': 'dromaeojs', 06:08:22 INFO - 'system_bits': '32', 06:08:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:22 INFO - 'title': 'talos-linux64-ix-016', 06:08:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:22 INFO - 'use_talos_json': True, 06:08:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:22 INFO - 'work_dir': 'build'} 06:08:22 INFO - ##### 06:08:22 INFO - ##### Running clobber step. 06:08:22 INFO - ##### 06:08:22 INFO - Running pre-action listener: _resource_record_pre_action 06:08:22 INFO - Running main action method: clobber 06:08:22 INFO - rmtree: /builds/slave/test/build 06:08:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:23 INFO - Running post-action listener: _resource_record_post_action 06:08:23 INFO - ##### 06:08:23 INFO - ##### Running read-buildbot-config step. 06:08:23 INFO - ##### 06:08:23 INFO - Running pre-action listener: _resource_record_pre_action 06:08:23 INFO - Running main action method: read_buildbot_config 06:08:23 INFO - Using buildbot properties: 06:08:23 INFO - { 06:08:23 INFO - "project": "", 06:08:23 INFO - "product": "firefox", 06:08:23 INFO - "script_repo_revision": "production", 06:08:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:08:23 INFO - "repository": "", 06:08:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:08:23 INFO - "buildid": "20160419230832", 06:08:23 INFO - "pgo_build": "False", 06:08:23 INFO - "basedir": "/builds/slave/test", 06:08:23 INFO - "buildnumber": 1586, 06:08:23 INFO - "slavename": "talos-linux64-ix-016", 06:08:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:08:23 INFO - "platform": "ubuntu64_hw", 06:08:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:08:23 INFO - "branch": "fx-team", 06:08:23 INFO - "repo_path": "integration/fx-team", 06:08:23 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 06:08:23 INFO - "stage_platform": "linux64", 06:08:23 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 06:08:23 INFO - "slavebuilddir": "test" 06:08:23 INFO - } 06:08:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:08:23 INFO - Running post-action listener: _resource_record_post_action 06:08:23 INFO - ##### 06:08:23 INFO - ##### Running download-and-extract step. 06:08:23 INFO - ##### 06:08:23 INFO - Running pre-action listener: _resource_record_pre_action 06:08:23 INFO - Running main action method: download_and_extract 06:08:23 INFO - mkdir: /builds/slave/test/build/tests 06:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:23 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:24 INFO - Downloaded 1361 bytes. 06:08:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:24 INFO - Using the following test package requirements: 06:08:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:08:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:08:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'jsshell-linux-x86_64.zip'], 06:08:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:08:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:08:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:08:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:08:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:08:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:24 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:25 INFO - Downloaded 22267191 bytes. 06:08:25 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'] 06:08:25 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 06:08:26 INFO - Return code: 0 06:08:26 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 06:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:26 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:27 INFO - Downloaded 22267191 bytes. 06:08:27 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'] 06:08:27 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 06:08:29 INFO - Return code: 0 06:08:29 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')]} 06:08:29 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:30 INFO - Downloaded 10845952 bytes. 06:08:30 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'] 06:08:30 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 06:08:30 INFO - Return code: 0 06:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:30 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:08:32 INFO - Downloaded 54589518 bytes. 06:08:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:32 INFO - mkdir: /builds/slave/test/properties 06:08:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:32 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:32 INFO - Contents: 06:08:32 INFO - build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:33 INFO - Running post-action listener: _resource_record_post_action 06:08:33 INFO - Running post-action listener: set_extra_try_arguments 06:08:33 INFO - ##### 06:08:33 INFO - ##### Running populate-webroot step. 06:08:33 INFO - ##### 06:08:33 INFO - Running pre-action listener: _resource_record_pre_action 06:08:33 INFO - Running main action method: populate_webroot 06:08:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:33 INFO - '--tppagecycles', 06:08:33 INFO - '7'], 06:08:33 INFO - 'tests': ['tsvgm']}}, 06:08:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:08:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:08:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['damp', 'tps']}, 06:08:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'tests': ['damp', 'tps']}, 06:08:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['dromaeo_dom']}, 06:08:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'other-e10s': {'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['a11yr', 06:08:33 INFO - 'ts_paint', 06:08:33 INFO - 'tpaint', 06:08:33 INFO - 'sessionrestore', 06:08:33 INFO - 'sessionrestore_no_auto_restore', 06:08:33 INFO - 'tabpaint']}, 06:08:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['tsvgx', 06:08:33 INFO - 'tsvgr_opacity', 06:08:33 INFO - 'tart', 06:08:33 INFO - 'tscrollx', 06:08:33 INFO - 'cart']}, 06:08:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:08:33 INFO - 'tsvgr_opacity', 06:08:33 INFO - 'tart', 06:08:33 INFO - 'tscrollx', 06:08:33 INFO - 'cart']}, 06:08:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'talos_options': ['--disable-e10s'], 06:08:33 INFO - 'tests': ['tp5o']}, 06:08:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'tests': ['tp5o']}, 06:08:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'talos_options': ['--disable-e10s', 06:08:33 INFO - '--xperf_path', 06:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:33 INFO - 'tests': ['tp5n']}, 06:08:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:33 INFO - 'talos_options': ['--xperf_path', 06:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:33 INFO - 'tests': ['tp5n']}}, 06:08:33 INFO - 'talos.zip': {'path': '', 06:08:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:33 INFO - Running post-action listener: _resource_record_post_action 06:08:33 INFO - ##### 06:08:33 INFO - ##### Running create-virtualenv step. 06:08:33 INFO - ##### 06:08:33 INFO - Running pre-action listener: _resource_record_pre_action 06:08:33 INFO - Running main action method: create_virtualenv 06:08:33 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:33 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 06:08:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:33 INFO - Using real prefix '/usr' 06:08:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:34 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:36 INFO - Installing pip.................done. 06:08:36 INFO - Return code: 0 06:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:08:36 INFO - Using env: {'DISPLAY': ':0', 06:08:36 INFO - 'HOME': '/home/cltbld', 06:08:36 INFO - 'LANG': 'en_US.UTF-8', 06:08:36 INFO - 'LANGUAGE': 'en_US:en', 06:08:36 INFO - 'LOGNAME': 'cltbld', 06:08:36 INFO - 'MAIL': '/var/mail/cltbld', 06:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:36 INFO - 'MOZ_NO_REMOTE': '1', 06:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:36 INFO - 'NO_EM_RESTART': '1', 06:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:36 INFO - 'PWD': '/builds/slave/test', 06:08:36 INFO - 'SHELL': '/bin/bash', 06:08:36 INFO - 'SHLVL': '1', 06:08:36 INFO - 'TERM': 'linux', 06:08:36 INFO - 'TMOUT': '86400', 06:08:36 INFO - 'USER': 'cltbld', 06:08:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:36 INFO - '_': '/tools/buildbot/bin/python'} 06:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:36 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 06:08:36 INFO - Cleaning up... 06:08:36 INFO - Return code: 0 06:08:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:08:36 INFO - Using env: {'DISPLAY': ':0', 06:08:36 INFO - 'HOME': '/home/cltbld', 06:08:36 INFO - 'LANG': 'en_US.UTF-8', 06:08:36 INFO - 'LANGUAGE': 'en_US:en', 06:08:36 INFO - 'LOGNAME': 'cltbld', 06:08:36 INFO - 'MAIL': '/var/mail/cltbld', 06:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:36 INFO - 'MOZ_NO_REMOTE': '1', 06:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:36 INFO - 'NO_EM_RESTART': '1', 06:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:36 INFO - 'PWD': '/builds/slave/test', 06:08:36 INFO - 'SHELL': '/bin/bash', 06:08:36 INFO - 'SHLVL': '1', 06:08:36 INFO - 'TERM': 'linux', 06:08:36 INFO - 'TMOUT': '86400', 06:08:36 INFO - 'USER': 'cltbld', 06:08:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:36 INFO - '_': '/tools/buildbot/bin/python'} 06:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:36 INFO - Downloading/unpacking psutil>=0.7.1 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:38 INFO - Installing collected packages: psutil 06:08:38 INFO - Running setup.py install for psutil 06:08:38 INFO - building 'psutil._psutil_linux' extension 06:08:38 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 06:08:38 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 06:08:38 INFO - building 'psutil._psutil_posix' extension 06:08:38 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 06:08:38 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 06:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:38 INFO - Successfully installed psutil 06:08:38 INFO - Cleaning up... 06:08:39 INFO - Return code: 0 06:08:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:08:39 INFO - Using env: {'DISPLAY': ':0', 06:08:39 INFO - 'HOME': '/home/cltbld', 06:08:39 INFO - 'LANG': 'en_US.UTF-8', 06:08:39 INFO - 'LANGUAGE': 'en_US:en', 06:08:39 INFO - 'LOGNAME': 'cltbld', 06:08:39 INFO - 'MAIL': '/var/mail/cltbld', 06:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:39 INFO - 'MOZ_NO_REMOTE': '1', 06:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:39 INFO - 'NO_EM_RESTART': '1', 06:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:39 INFO - 'PWD': '/builds/slave/test', 06:08:39 INFO - 'SHELL': '/bin/bash', 06:08:39 INFO - 'SHLVL': '1', 06:08:39 INFO - 'TERM': 'linux', 06:08:39 INFO - 'TMOUT': '86400', 06:08:39 INFO - 'USER': 'cltbld', 06:08:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:39 INFO - '_': '/tools/buildbot/bin/python'} 06:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:08:41 INFO - Installing collected packages: mozsystemmonitor 06:08:41 INFO - Running setup.py install for mozsystemmonitor 06:08:41 INFO - Successfully installed mozsystemmonitor 06:08:41 INFO - Cleaning up... 06:08:41 INFO - Return code: 0 06:08:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:08:41 INFO - Using env: {'DISPLAY': ':0', 06:08:41 INFO - 'HOME': '/home/cltbld', 06:08:41 INFO - 'LANG': 'en_US.UTF-8', 06:08:41 INFO - 'LANGUAGE': 'en_US:en', 06:08:41 INFO - 'LOGNAME': 'cltbld', 06:08:41 INFO - 'MAIL': '/var/mail/cltbld', 06:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:41 INFO - 'MOZ_NO_REMOTE': '1', 06:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:41 INFO - 'NO_EM_RESTART': '1', 06:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:41 INFO - 'PWD': '/builds/slave/test', 06:08:41 INFO - 'SHELL': '/bin/bash', 06:08:41 INFO - 'SHLVL': '1', 06:08:41 INFO - 'TERM': 'linux', 06:08:41 INFO - 'TMOUT': '86400', 06:08:41 INFO - 'USER': 'cltbld', 06:08:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:41 INFO - '_': '/tools/buildbot/bin/python'} 06:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:44 INFO - Downloading docopt-0.6.1.tar.gz 06:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:44 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:44 INFO - Running setup.py install for blobuploader 06:08:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:44 INFO - Running setup.py install for requests 06:08:44 INFO - Running setup.py install for docopt 06:08:44 INFO - Successfully installed blobuploader requests docopt 06:08:44 INFO - Cleaning up... 06:08:44 INFO - Return code: 0 06:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:44 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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:44 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 06:08:44 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 06:08:44 INFO - Using env: {'DISPLAY': ':0', 06:08:44 INFO - 'HOME': '/home/cltbld', 06:08:44 INFO - 'LANG': 'en_US.UTF-8', 06:08:44 INFO - 'LANGUAGE': 'en_US:en', 06:08:44 INFO - 'LOGNAME': 'cltbld', 06:08:44 INFO - 'MAIL': '/var/mail/cltbld', 06:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:44 INFO - 'MOZ_NO_REMOTE': '1', 06:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:44 INFO - 'NO_EM_RESTART': '1', 06:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:44 INFO - 'PWD': '/builds/slave/test', 06:08:44 INFO - 'SHELL': '/bin/bash', 06:08:44 INFO - 'SHLVL': '1', 06:08:44 INFO - 'TERM': 'linux', 06:08:44 INFO - 'TMOUT': '86400', 06:08:44 INFO - 'USER': 'cltbld', 06:08:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:44 INFO - '_': '/tools/buildbot/bin/python'} 06:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:45 INFO - Running setup.py (path:/tmp/pip-QIopPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:45 INFO - Running setup.py (path:/tmp/pip-XQmMwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:45 INFO - Running setup.py (path:/tmp/pip-X6styC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:45 INFO - Running setup.py (path:/tmp/pip-hFOq1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:45 INFO - Running setup.py (path:/tmp/pip-0Zk8cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:45 INFO - Running setup.py (path:/tmp/pip-wAvsPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:45 INFO - Running setup.py (path:/tmp/pip-JEdUuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:45 INFO - Running setup.py (path:/tmp/pip-CAKOf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:45 INFO - Running setup.py (path:/tmp/pip-xa9MYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:45 INFO - Running setup.py (path:/tmp/pip-gVJQ2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:45 INFO - Running setup.py (path:/tmp/pip-o6_sRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:45 INFO - Running setup.py (path:/tmp/pip-abTcQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:45 INFO - Running setup.py (path:/tmp/pip-fqyCDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:45 INFO - Running setup.py (path:/tmp/pip-dJvCYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:46 INFO - Running setup.py (path:/tmp/pip-AGa6vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:46 INFO - Running setup.py (path:/tmp/pip-XKqo1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:46 INFO - Running setup.py (path:/tmp/pip-sGZOyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:46 INFO - Running setup.py install for manifestparser 06:08:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:46 INFO - Running setup.py install for mozcrash 06:08:46 INFO - Running setup.py install for mozdebug 06:08:46 INFO - Running setup.py install for mozdevice 06:08:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:46 INFO - Running setup.py install for mozfile 06:08:46 INFO - Running setup.py install for mozhttpd 06:08:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:46 INFO - Running setup.py install for mozinfo 06:08:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:46 INFO - Running setup.py install for mozInstall 06:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Running setup.py install for mozleak 06:08:47 INFO - Running setup.py install for mozlog 06:08:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Running setup.py install for moznetwork 06:08:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Running setup.py install for mozprocess 06:08:47 INFO - Running setup.py install for mozprofile 06:08:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Running setup.py install for mozrunner 06:08:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:47 INFO - Running setup.py install for mozscreenshot 06:08:47 INFO - Running setup.py install for moztest 06:08:47 INFO - Running setup.py install for mozversion 06:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:48 INFO - Cleaning up... 06:08:48 INFO - Return code: 0 06:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:48 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')]} 06:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:48 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')]} 06:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:48 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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:48 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 06:08:48 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 06:08:48 INFO - Using env: {'DISPLAY': ':0', 06:08:48 INFO - 'HOME': '/home/cltbld', 06:08:48 INFO - 'LANG': 'en_US.UTF-8', 06:08:48 INFO - 'LANGUAGE': 'en_US:en', 06:08:48 INFO - 'LOGNAME': 'cltbld', 06:08:48 INFO - 'MAIL': '/var/mail/cltbld', 06:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:48 INFO - 'MOZ_NO_REMOTE': '1', 06:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:48 INFO - 'NO_EM_RESTART': '1', 06:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:48 INFO - 'PWD': '/builds/slave/test', 06:08:48 INFO - 'SHELL': '/bin/bash', 06:08:48 INFO - 'SHLVL': '1', 06:08:48 INFO - 'TERM': 'linux', 06:08:48 INFO - 'TMOUT': '86400', 06:08:48 INFO - 'USER': 'cltbld', 06:08:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:48 INFO - '_': '/tools/buildbot/bin/python'} 06:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:48 INFO - Running setup.py (path:/tmp/pip-lrl3id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:48 INFO - Running setup.py (path:/tmp/pip-zyFDCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:48 INFO - Running setup.py (path:/tmp/pip-Ee4tOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:48 INFO - Running setup.py (path:/tmp/pip-AlUJuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:48 INFO - Running setup.py (path:/tmp/pip-CIzMc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:48 INFO - Running setup.py (path:/tmp/pip-AOpaOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:48 INFO - Running setup.py (path:/tmp/pip-ybvNQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:48 INFO - Running setup.py (path:/tmp/pip-Vt_B59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:48 INFO - Running setup.py (path:/tmp/pip-mT6z7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:48 INFO - Running setup.py (path:/tmp/pip-CFsjcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:48 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)) 06:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:48 INFO - Running setup.py (path:/tmp/pip-JLeKAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:49 INFO - Running setup.py (path:/tmp/pip-mZ0fIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:49 INFO - Running setup.py (path:/tmp/pip-mx5MWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:49 INFO - Running setup.py (path:/tmp/pip-XgIOQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:49 INFO - Running setup.py (path:/tmp/pip-AXYvaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:49 INFO - Running setup.py (path:/tmp/pip-b1cgtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:49 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)) 06:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:49 INFO - Running setup.py (path:/tmp/pip-UV5f1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:51 INFO - Downloading blessings-1.6.tar.gz 06:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:51 INFO - Installing collected packages: blessings 06:08:51 INFO - Running setup.py install for blessings 06:08:51 INFO - Successfully installed blessings 06:08:51 INFO - Cleaning up... 06:08:51 INFO - Return code: 0 06:08:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:51 INFO - Reading from file tmpfile_stdout 06:08:51 INFO - Current package versions: 06:08:51 INFO - argparse == 1.2.1 06:08:51 INFO - blessings == 1.6 06:08:51 INFO - blobuploader == 1.2.4 06:08:51 INFO - docopt == 0.6.1 06:08:51 INFO - manifestparser == 1.1 06:08:51 INFO - mozInstall == 1.12 06:08:51 INFO - mozcrash == 0.17 06:08:51 INFO - mozdebug == 0.1 06:08:51 INFO - mozdevice == 0.48 06:08:51 INFO - mozfile == 1.2 06:08:51 INFO - mozhttpd == 0.7 06:08:51 INFO - mozinfo == 0.9 06:08:51 INFO - mozleak == 0.1 06:08:51 INFO - mozlog == 3.1 06:08:51 INFO - moznetwork == 0.27 06:08:51 INFO - mozprocess == 0.22 06:08:51 INFO - mozprofile == 0.28 06:08:51 INFO - mozrunner == 6.11 06:08:51 INFO - mozscreenshot == 0.1 06:08:51 INFO - mozsystemmonitor == 0.0 06:08:51 INFO - moztest == 0.7 06:08:51 INFO - mozversion == 1.4 06:08:51 INFO - psutil == 3.1.1 06:08:51 INFO - requests == 1.2.3 06:08:51 INFO - wsgiref == 0.1.2 06:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:51 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')]} 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:51 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')]} 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:51 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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:51 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 06:08:51 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 06:08:51 INFO - Using env: {'DISPLAY': ':0', 06:08:51 INFO - 'HOME': '/home/cltbld', 06:08:51 INFO - 'LANG': 'en_US.UTF-8', 06:08:51 INFO - 'LANGUAGE': 'en_US:en', 06:08:51 INFO - 'LOGNAME': 'cltbld', 06:08:51 INFO - 'MAIL': '/var/mail/cltbld', 06:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:51 INFO - 'MOZ_NO_REMOTE': '1', 06:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:51 INFO - 'NO_EM_RESTART': '1', 06:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:51 INFO - 'PWD': '/builds/slave/test', 06:08:51 INFO - 'SHELL': '/bin/bash', 06:08:51 INFO - 'SHLVL': '1', 06:08:51 INFO - 'TERM': 'linux', 06:08:51 INFO - 'TMOUT': '86400', 06:08:51 INFO - 'USER': 'cltbld', 06:08:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:51 INFO - '_': '/tools/buildbot/bin/python'} 06:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 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)) 06:08:52 INFO - Cleaning up... 06:08:52 INFO - Return code: 0 06:08:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08:52 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')]} 06:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:52 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')]} 06:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:52 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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:52 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 06:08:52 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 06:08:52 INFO - Using env: {'DISPLAY': ':0', 06:08:52 INFO - 'HOME': '/home/cltbld', 06:08:52 INFO - 'LANG': 'en_US.UTF-8', 06:08:52 INFO - 'LANGUAGE': 'en_US:en', 06:08:52 INFO - 'LOGNAME': 'cltbld', 06:08:52 INFO - 'MAIL': '/var/mail/cltbld', 06:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:52 INFO - 'MOZ_NO_REMOTE': '1', 06:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:52 INFO - 'NO_EM_RESTART': '1', 06:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:52 INFO - 'PWD': '/builds/slave/test', 06:08:52 INFO - 'SHELL': '/bin/bash', 06:08:52 INFO - 'SHLVL': '1', 06:08:52 INFO - 'TERM': 'linux', 06:08:52 INFO - 'TMOUT': '86400', 06:08:52 INFO - 'USER': 'cltbld', 06:08:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:52 INFO - '_': '/tools/buildbot/bin/python'} 06:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:52 INFO - Downloading/unpacking jsonschema 06:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:08:54 INFO - Downloading/unpacking functools32 (from jsonschema) 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:08:54 INFO - warning: no files found matching '*.txt' 06:08:54 INFO - no previously-included directories found matching 'build' 06:08:54 INFO - no previously-included directories found matching 'dist' 06:08:54 INFO - no previously-included directories found matching '.git*' 06:08:54 INFO - Installing collected packages: jsonschema, functools32 06:08:54 INFO - Running setup.py install for functools32 06:08:54 INFO - warning: no files found matching '*.txt' 06:08:54 INFO - no previously-included directories found matching 'build' 06:08:54 INFO - no previously-included directories found matching 'dist' 06:08:54 INFO - no previously-included directories found matching '.git*' 06:08:54 INFO - Successfully installed jsonschema functools32 06:08:54 INFO - Cleaning up... 06:08:54 INFO - Return code: 0 06:08:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08:54 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')]} 06:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:54 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')]} 06:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:54 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 0x7fee6ba20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, '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': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', '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 06:08:54 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 06:08:54 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 06:08:54 INFO - Using env: {'DISPLAY': ':0', 06:08:54 INFO - 'HOME': '/home/cltbld', 06:08:54 INFO - 'LANG': 'en_US.UTF-8', 06:08:54 INFO - 'LANGUAGE': 'en_US:en', 06:08:54 INFO - 'LOGNAME': 'cltbld', 06:08:54 INFO - 'MAIL': '/var/mail/cltbld', 06:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:54 INFO - 'MOZ_NO_REMOTE': '1', 06:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:54 INFO - 'NO_EM_RESTART': '1', 06:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:54 INFO - 'PWD': '/builds/slave/test', 06:08:54 INFO - 'SHELL': '/bin/bash', 06:08:54 INFO - 'SHLVL': '1', 06:08:54 INFO - 'TERM': 'linux', 06:08:54 INFO - 'TMOUT': '86400', 06:08:54 INFO - 'USER': 'cltbld', 06:08:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:54 INFO - '_': '/tools/buildbot/bin/python'} 06:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:54 INFO - Downloading/unpacking flake8 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:54 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 06:08:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:56 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 06:08:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:57 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 06:08:57 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 06:08:57 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 06:08:57 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 06:08:57 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 06:08:57 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 06:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:57 INFO - no previously-included directories found matching 'docs/_build' 06:08:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:57 INFO - Running setup.py install for pep8 06:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:57 INFO - no previously-included directories found matching 'docs/_build' 06:08:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:57 INFO - Cleaning up... 06:08:57 INFO - Return code: 0 06:08:57 INFO - Running post-action listener: _resource_record_post_action 06:08:57 INFO - Running post-action listener: _start_resource_monitoring 06:08:57 INFO - Starting resource monitoring. 06:08:57 INFO - ##### 06:08:57 INFO - ##### Running install step. 06:08:57 INFO - ##### 06:08:57 INFO - Running pre-action listener: _resource_record_pre_action 06:08:57 INFO - Running main action method: install 06:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:57 INFO - Reading from file tmpfile_stdout 06:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:57 INFO - Reading from file tmpfile_stdout 06:08:57 INFO - Output received: 06:08:57 INFO - Usage: mozinstall [options] installer 06:08:57 INFO - Options: 06:08:57 INFO - -h, --help show this help message and exit 06:08:57 INFO - -d DEST, --destination=DEST 06:08:57 INFO - Directory to install application into. [default: 06:08:57 INFO - "/builds/slave/test"] 06:08:57 INFO - --app=APP Application being installed. [default: firefox] 06:08:57 INFO - mkdir: /builds/slave/test/build/application 06:08:57 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'] 06:08:57 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 06:09:13 INFO - Reading from file tmpfile_stdout 06:09:13 INFO - Output received: 06:09:13 INFO - /builds/slave/test/build/application/firefox/firefox 06:09:13 INFO - Running post-action listener: _resource_record_post_action 06:09:13 INFO - ##### 06:09:13 INFO - ##### Running run-tests step. 06:09:13 INFO - ##### 06:09:13 INFO - Running pre-action listener: _resource_record_pre_action 06:09:13 INFO - Running main action method: run_tests 06:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:13 INFO - Python 2.7.3 06:09:13 INFO - Return code: 0 06:09:13 INFO - grabbing minidump binary from tooltool 06:09:13 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')]} 06:09:13 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 0x270a410>, '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 0x270b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:13 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 06:09:13 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 06:09:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:13 INFO - Return code: 0 06:09:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:09:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:09:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:14 INFO - Return code: 0 06:09:14 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:09:14 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 06:09:14 INFO - Using env: {'DISPLAY': ':0', 06:09:14 INFO - 'HOME': '/home/cltbld', 06:09:14 INFO - 'LANG': 'en_US.UTF-8', 06:09:14 INFO - 'LANGUAGE': 'en_US:en', 06:09:14 INFO - 'LOGNAME': 'cltbld', 06:09:14 INFO - 'MAIL': '/var/mail/cltbld', 06:09:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:14 INFO - 'MOZ_NO_REMOTE': '1', 06:09:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:14 INFO - 'NO_EM_RESTART': '1', 06:09:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:14 INFO - 'PWD': '/builds/slave/test', 06:09:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:14 INFO - 'SHELL': '/bin/bash', 06:09:14 INFO - 'SHLVL': '1', 06:09:14 INFO - 'TERM': 'linux', 06:09:14 INFO - 'TMOUT': '86400', 06:09:14 INFO - 'USER': 'cltbld', 06:09:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461330501.224147-155928191', 06:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:14 INFO - '_': '/tools/buildbot/bin/python'} 06:09:14 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:09:14 INFO - mozversion application_buildid: 20160419230832 06:09:14 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:09:14 INFO - mozversion application_display_name: Nightly 06:09:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:14 INFO - mozversion application_name: Firefox 06:09:14 INFO - mozversion application_remotingname: firefox 06:09:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:09:14 INFO - mozversion application_vendor: Mozilla 06:09:14 INFO - mozversion application_version: 48.0a1 06:09:14 INFO - mozversion platform_buildid: 20160419230832 06:09:14 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:09:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:09:14 INFO - mozversion platform_version: 48.0a1 06:09:14 INFO - using testdate: 1461330554 06:09:14 INFO - actual date: 1461330554 06:09:14 INFO - starting webserver on 'localhost:37790' 06:09:14 INFO - SUITE-START | Running 2 tests 06:09:14 INFO - TEST-START | dromaeo_css 06:09:14 INFO - operating with platform_type : linux_ 06:09:14 INFO - Initialising browser for dromaeo_css test... 06:09:14 INFO - TEST-INFO | started process 12459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJuVsar/profile http://localhost:37790/getInfo.html) 06:09:19 INFO - PROCESS | 12459 | __metrics Screen width/height:1600/1200 06:09:19 INFO - PROCESS | 12459 | colorDepth:24 06:09:19 INFO - PROCESS | 12459 | Browser inner width/height: 1024/697 06:09:19 INFO - PROCESS | 12459 | __metrics 06:09:20 ERROR - PROCESS | 12459 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:09:21 INFO - TEST-INFO | 12459: exit 0 06:09:21 INFO - Browser initialized. 06:09:21 INFO - Running cycle 1/1 for dromaeo_css test... 06:09:21 INFO - TEST-INFO | started process 12537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJuVsar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:33 INFO - PROCESS | 12537 | RSS: Main: 154906624 06:09:33 INFO - PROCESS | 12537 | 06:10:24 INFO - PROCESS | 12537 | 1461330624604 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] 06:12:36 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37790/tests/dromaeo/cssquery-ext.html) 06:12:37 INFO - PROCESS | 12537 | RSS: Main: 266760192 06:12:37 INFO - PROCESS | 12537 | 06:15:40 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-ext.html (next: http://localhost:37790/tests/dromaeo/cssquery-jquery.html) 06:15:40 INFO - PROCESS | 12537 | RSS: Main: 236539904 06:15:40 INFO - PROCESS | 12537 | 06:18:42 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37790/tests/dromaeo/cssquery-mootools.html) 06:18:43 INFO - PROCESS | 12537 | RSS: Main: 240852992 06:18:43 INFO - PROCESS | 12537 | 06:21:45 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37790/tests/dromaeo/cssquery-prototype.html) 06:21:45 INFO - PROCESS | 12537 | RSS: Main: 236146688 06:21:45 INFO - PROCESS | 12537 | 06:24:48 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37790/tests/dromaeo/cssquery-yui.html) 06:24:49 INFO - PROCESS | 12537 | RSS: Main: 216166400 06:24:49 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | Cycle 1(1): loaded http://localhost:37790/tests/dromaeo/cssquery-yui.html (next: http://localhost:37790/tests/dromaeo/cssquery-dojo.html) 06:27:52 INFO - PROCESS | 12537 | RSS: Main: 277381120 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | __start_tp_report 06:27:52 INFO - PROCESS | 12537 | _x_x_mozilla_page_load 06:27:52 INFO - PROCESS | 12537 | _x_x_mozilla_page_load_details 06:27:52 INFO - PROCESS | 12537 | |i|pagename|runs| 06:27:52 INFO - PROCESS | 12537 | |0;dojo.html;2593.1572239022316;2658.082961378324;2666.5066962611904;2678.2500899748065;2692.461507698461;4484.753338566377;4560.475545312282;4605.953940460595;4616.907661846765;4623.514530974246;4596.517365676606;4604.792784324705;4621.353010578513;4677.4854765975715;4692.389989301386;4201.264778663737;4218.472690913643;4263.829446822124;4290.699651024414;4372.453443319585;4346.130773845228;4366.978165109186;4383.517813040563;4390.5609439056;4412.338149277618;4162.625363717265;4203.327467605169;4229.70392072555;4292.313229883203;4309.396684464177;4214.641755450791;4254.149170165979;4267.893302667427;4267.997020700133;4307.82768689252;4189.706720529564;4189.790510474494;4190.245755763961;4218.91562168758;4223.87328380146;4323.156984388045;4431.512533621299;4456.153330867125;4497.550244975509;4561.7491037992895;4898.559129678346;4902.460729319772;4910.165271903785;4912.901741965176;4962.801487940478;4903.338049363326;4914.827981020647;4925.605951523869;4944.8269310574315;4955.950440495585;4481.753503557303;4553.772311384418;4614.146382919171;4647.814087436533;4648.581627653527;5061;5061.620378471629;5072.721000344943;5075.847724568269;5076.314697515862;4868.123737727243;4872.731999740048;4875.536824001714;4889.315495830587;4947.406311242602;4762.190427627312;4892.094962431962;4934.55588996992;4969.676970996946;4974.577160941288;4818.10864989978;4833.081714474239;4840.491748366441;4859.125357435625;4910.607151427877;4663.090697314059;4821.349117869113;4831.371921650233;4849.345338379344;4895.828645997373;4140.4617399737845;4196.664266858705;4203.390508376268;4204.348326009474;4216.936745948813;3667.6149004354693;3696.039029852258;3700.4264339027495;3711.9443208351895;3726;4260;4283.850065247763;4288.8284468620905;4296.892577685583;4316.740995540277;4813.831515896927;4879.1461494238365;4938.38270216223;4956.3804524434445;4959.256111583291;4261.21167583998;4276.102018576134;4295.334223195409;4299.914001720011;4337.869863904088;4464.241079016575;4500.257457519538;4502.5047244803045;4545.818167273272;4548.47692515365;4515.68390212682;4695.929561056655;4723.929141062956;4767.61859051282;4779.904401912012;4879.170541008109;4887.902241955212;4906.95093049065;4925.778339974638;4956.702597844141;4600.769961501845;4650.4186976627925;4670.556297151765;4679.110968915895;4717.43390793107;4827.782749776198;4831.565159135695;4841.515848415131;4892.779824907959;4899.11815873132;4835.854924352275;4842.782074806712;4860;4861.343718597944;4915;4613.607843333354;4732.716037037789;4734.526547345238;4777.235642297216;4791.616670666269;4757.33397324368;4776.713397196179;4780.067886762048;4781.402324709411;4818.325434439112;4699.577038066591;4703.670743047954;4710.034442939258;4741.407324084489;4746.905061898674;4649.721016739007;4776.355192049029;4820.734859582757;4850.369451971221;4862.756862156807;4571;4631.745254010927;4643.558861908114;4648.140094082605;4648.604868586208 06:27:52 INFO - PROCESS | 12537 | |1;ext.html;570.6804189653794;588.396893184486;589.1722130406778;597.4055814464608;612.770211170811;28614.284642883937;33819.83090084549;34937.47593786095;34968;35104.82447587758;40128;41094;41311;41385.58614413855;41387.17225655485;7261.3101755333155;7442.962785186067;7443.516171448866;7695.307422331989;7944.920550794476;7349.963250183741;9604.807903841918;9952.203823694088;9974.800503989916;10036.14692751117;9957.302988790787;10077.44574048427;10084;10084.647037353694;10086;7437.590932498711;7739.922600774033;9888.40669559825;9991.100800927916;10004;7342.632868356561;9378.109079637423;9599.4720290384;9602.183814375787;9603.519824008841;34479.655203447895;34998.825005875064;35108.824455877555;35184.47223291652;35251.4712279316;3012.0361484325026;3030.6666266710645;3049.283418396675;3123.9219019524467;3237.3848968695875;29277.85361073202;29495.410091798043;29769.702302976908;29786.404271914656;29810.70189298101;3308.9172770680925;3346.949795753041;3384.4415671414185;3408.659134086596;3444.5522082129164;239016;239164;242809;243046;243076;56504.15243771347;57175.14237286444;57221;57261.42738572561;57409.71295143581;59759.40240597625;61261;61414.692926535085;61434.38565614287;61468.77062458815;13409.128406653535;13567.1859688419;13623.795643065361;13623.795643065361;13630.727385452434;9545.665901693408;10077.29458937882;10277;10332.948335258427;10456.790864182674;18350.26598936054;18374.63250734978;18410.539736506427;18422.539436513925;18470.907645461688;7093.219745827955;7301.452391070691;7364.3372096511575;7603.809904752315;7668.233176682287;886.4636894678755;934.8644446555347;973.6932866147141;975.9658411955547;1013.108464551205;27144.1856744298;28358;28879.85560072186;29651.40697186044;30360.54459183114;989.980200395988;998.9300748947504;1008.3093081239374;1098.242212873115;1118.4854966715402;13845.446182152802;14457.566273011826;14505.095768727337;14520.927395362956;14644.414223431157;357005;364850;365172;365537;367265;46648.5335146651;47368.52631473641;47518;47778.761106194244;47879;1145.0896537252904;1213.854337479508;1233.1491271022965;1275.2858399296424;1309.4892991733423;24597;26252.73747262503;27795.861020694767;27917.302067448476;27924.860375698805;38826.2234755309;39553.406698900115;39625.207495850496;39718.40422393724;39737.60262397455;264265;265480;265704;266306;266808;21872.562548749254;24120;25197.370065748502;25948.610770838073;25968.350791230372;34925.30149397049;35104.64895351116;35478;35565.644343557266;35679.64320356763;30282;30801.38397231998;30939.535906960962;31099.533506997865;31331.68668313379;31508;33017.33965320728;33218.833905831285;33365.666343336256;33531.161720956195;32784.34431311408;33387.332253355286;33655.326893461504;33742.32515349728;33837.66162338345;30046;30323;30415.847920760254;30420.239494012825;30480.542791857697;23538.176163834185;23779.844282044534;23974.640380393957;24002.39994000164;24318.513629726953 06:27:52 INFO - PROCESS | 12537 | |2;jquery.html;376.16303724213617;376.6026841682024;382.32519602900885;384.63843986652563;388.36890053662796;15750.13374264415;15753.763693544606;16766.329346826144;16774.161291935387;16782.412615558456;9976.50117494126;10747.677569672902;10766.35401875888;10781.299215550984;10786.5685372585;4714.222153344694;4856.781444834974;4888.242322440027;4892.241702536113;4915.950840491585;4686.437627484706;4822.300766388889;4831.782569784368;4835.15384807659;4844.87887802806;4786.904261914759;4824.975875120619;4832.492588278233;4837.612990960714;4853.053654537367;4706;4784.210605250129;4834.7824347904425;4877.804887804484;4877.804887804484;4465.531119232466;4709.081729062834;4718.952810471886;4724.7401392923375;4731.195696731564;19024;19622;19821;19856.30502932405;19948.50128746793;1849.4821449994024;1878.2768634075842;1912.1108684461653;1929.4018854155117;1959.2848610257297;8856.158664926821;9201.67794127209;9466.621335146587;9486.478243696594;9536.904630953672;1707.5901783571978;1755.4470341842407;1803.5310819187105;1833.8074502177346;1848.2791711232496;66023.66988165077;66075;66259.33740662532;66297.66851165761;67364.6631766838;9769.68109305249;9770.951145244371;9788.265880058882;9888.901110988798;9937.602495900228;13517.932410337886;13612.183269003892;13640.795388069188;13644.249566273751;13648.112872663245;6738.19141702989;6826.829329266808;6856;6932.549384290005;6958.269381714948;6227.564070515111;6315.652639104802;6428.614283143026;6458;6465.674536719961;4184.832606695759;4266.466691663542;4273;4380.123975204971;4388.05656783793;1785.8928464292185;1854.8887066776037;1876.2138224736257;1877.9624407512047;1892.3944337811768;792.6274650914061;851.3317046118767;852.5140669818144;887.8535041718173;928.8513837785922;16103.194840258175;16392.426265080663;16605.6678866422;16629.3348266068;17121.743173852403;874.4054043250524;878.6661068793945;897.4077109108088;926.1525703980917;933.5798890499302;9084.599521653028;9562.904370956341;9591.42451452915;9645.180159686364;9709.951450242703;376123;379476.4418786702;384148;386832;387767;78098.2190178091;79019.60490197512;79121;79311.60344198358;80190;934.56075644447;967.2068903499204;973.4062222044547;992.0228574853763;994.7363948553639;15219.162946038074;15259.160746159068;15384.307706153473;15535;15956.680866382376;32907;33564.160895977795;34115.31769364649;34327;34684.30631387408;48371.27443088427;49219;49516;49551.50448495613;49574.256386153516;7768.572728499987;7956.283934445928;7978;7989.320907722677;8074.717384891501;8509;11247.943760281147;11320.320780753182;11640.825387619361;11863.881361186277;9919.355241909252;10197.490125493843;10328.173746100445;10383.896161038596;10589.788204235718;10065.144462720751;10201.948990255001;10351.948240258751;10378.584856605954;10381.584736610754;10241.385516869012;10273.229507787095;10406.687799366031;10478.580856765644;10768.438576406534;7554.584497852671;7721.652525636247;7871.370290376871;7949.364050876032;8140.226678465537;9007;10216.233782466494;10468.214883883587;10490.31812932157;10501.9474902625 06:27:52 INFO - PROCESS | 12537 | |3;mootools.html;1279.047109903121;1442.624917521444;1458.0814087125113;1603.59108427351;1775.6093659394937;6760.729570817168;7438.814029649261;7625.237476252372;7634.00757901472;7647.502912310702;7458.179600243982;7626.466147369686;7633.160352361236;7640.732574359885;7647.579383133925;2169.0022589608798;2183.759786423492;2191.5288213034196;2202.3503066595313;2203.5813195492806;2200.8679479231296;2225.877576733279;2245.382519807058;2246.1352379333994;2250.5386395788905;2210.5136869888597;2227.7326720793526;2237.5636750833596;2239.484918468753;2250.3024062540585;2142.1324363632752;2166.5775173841107;2170.5333353329033;2179.7711240319777;2179.9673004905017;2138.7968143026387;2150.688150218225;2151.354593621907;2152.687860260269;2156.8490205685607;7644.808879777995;7713.112992005935;7748.922510774876;7767.495112817649;7777.611119444062;4613.1696294666945;4729.337892695025;4732.763361831895;4768.189407800683;4771.427428708543;2973.568832519294;3003.654579723316;3046.0709483607493;3054.099040782952;3070.8464576771294;937.339175881009;944.9433034017981;952.0431965874252;958.8753462049958;960.8606752020987;9757.414555126716;10011.19910407173;10036.197104231716;10064.798704025878;10073;3901.7073719471155;4029.8589549365634;4150.460440142822;4161.396597493346;4175.68682348825;8088.636011379502;8138.959305203436;8146.470479418819;8154.266116049584;8176.977877765279;4582.495925448198;4592.6555508337005;4594.736447476904;4616.261398176276;4629.305604159403;3739.420389839525;4213;4304.053108316165;4316.223079845595;4384.868453946387;3503.667151620592;3522;3546.361654902142;3586.4799604057266;3617.2403795203304;1104.0780947908586;1118.0273162348647;1119.4346854838254;1119.7200699825044;1142.5030111901349;768.815484283779;877.7366789962986;892.683097500391;923.1184219070906;929.6606738540384;5590.776368945197;5603.80386686464;5772.422757724194;5794.21778059965;5895.970520147458;914.995425022884;916.5966974531318;932.6036434515304;936.1200471556715;944.8960614332418;3857.3056849767313;3859.671927886161;3886.4753258309765;3949.0917089069676;4122.9381559276635;9765.707028789147;10089.293749437616;10176.389416635026;10198.949005254926;10211.642592509226;10101.898981010243;10110.292279540361;10120.544575494121;10120.848187277197;10131.594736210616;6983.301669832976;7246.746363877133;7255.854882902418;7411.332980031823;7450.776476705708;5572.080606699849;5639.943600563942;5770.826875193751;5811.622244554091;5848.5028772553105;8896.555172241233;9125.406848554823;9154.450732956044;9220.124088211609;9365.11031452011;9200.263978881807;9275;9290.95354523223;9358.719238422858;9457.905420945703;5904.527637789052;6043.758249669964;6513.2835388108215;6848.7260509579055;6964.373206411447;7397.963010184914;7426.220246874216;7510.098788145239;7526.285002924714;7529;6652.10196623469;6723.697433615597;6811.965940170466;6828.795136145924;6966.198887127843;6745.325467453215;6783.762568310085;6805.455563555002;6821.897671534832;6828.351306625863;6247.562670613013;6368.203974503187;6422.871542569216;6428.517861160338;6432.871342573216;4542.1824071667415;4563.269876819693;4605.792739326671;4646.953530464652;4648.1168577970075;4636.420447444069;4693.9765301173275;4784.6889952153;4800.399950006249;4834.903301934012 06:27:52 INFO - PROCESS | 12537 | |4;prototype.html;305.34503490013935;316.70704598246624;321.9694129057739;322.62414287355233;325.83708145927034;4958.553730164284;4981.900361992758;5052.823151189709;5059.190529515278;5079.3904731432185;4694.225452800284;4767.2134097873895;4849.272609108635;4965.535167125698;5004.399472063348;3958.6239307265764;3989.1822176453757;3996.6003399660094;3997.7601343919314;4010.1578668479656;3990.08228107534;3994;3997.98001009996;4009.939850902239;4011.3782363733667;3704.7591906526122;3807.9809600952094;3937.6849852011915;3952.7035472339544;3965.5637879833193;3928.960710392888;3937.4093885917055;3944.1322908959983;3952.8221230044574;3963.3049526321947;3507.3336066147604;3510.877119300838;3513.332466831294;3516.2791627716256;3522.277933023724;4688.718676879398;4761.285937062655;4792.7124372537755;4798.160321943646;4799.712017278975;4487.551244875519;4514.210013247669;4515.864524064284;4531.43357080365;4536.500984891659;5210.140326846066;5221.817236396746;5234.26720259164;5236.162214045772;5241.187615919539;3731.533558305212;3774.75464094833;3826.8660596878976;3833.884983450473;3836.156045669948;5480.232767412565;5489.64317319373;5492.665617112751;5499.945000549983;5501.752421141058;3893.6885049196;3907.7069219808627;3913.25648126855;3914.432407300925;3920.2747491713553;3964.9008774780286;3975.4036894465485;3978.0850404407147;3979.3235150024566;3981;4361.476622805284;4469.7318160910445;4474.821007159742;4478.507364189936;4501.459824821042;5194.168932970707;5201.245819356172;5216.321878155815;5222.138347172674;5225.16397376418;1293.4761421624257;1340.2226708509236;1373.1349249972454;1390.3812803302433;1392.4291040673477;942.4157022646003;958.0611001218845;967.6516454076527;970.1947383671536;975.4001289207087;4543.386642803245;4544.250198717241;4556.0432309214775;4572.245579479349;4598.241290187082;5332.946670533245;5357.330333708286;5366.785328586813;5367.355917289872;5372.113601255827;4441.156180325728;4580.335851301543;4598.425196850394;4601.079784043138;4602.631789456836;2841.758450531728;2875.266806964211;2883.3800732842537;2891.7108289170915;2903.637045369329;5124.487551244845;5125.205593133071;5130.692158470503;5137.8715532112;5143.691378517301;5311.256424100629;5507.621440954451;5517.806876759294;5529.198266251451;5627.212190293362;5164.586833053422;5187.714675692873;5194.740262986836;5196.58427325813;5202.219667049897;5455.754491047833;5462.508374246337;5467.480589344006;5476;5476.424975377688;5255.894882102413;5360;5363.168708850135;5377.354717433776;5381.865453363697;5159.458256883124;5164.586833053271;5177.430482646982;5196.856691527858;5199.324087868553;3752.212035472472;3779.6976241900034;3794.0704527390967;3796.2597293527497;3797.278517081856;5189.532942035235;5236.266922630911;5432.945670543244;5435.782568697208;5442.755076021509;5075.1625981712605;5238.5023422774775;5252.107141785829;5255.605829562722;5270.89458210826;5238.76425560843;5257.316548848626;5265.4997775211295;5265.52610265078;5286.682799032071;4896.143174944442;5128.512791284822;5168.234994278194;5173.482651734947;5205.947940520547;5274.657147285414;5286.920696189637;5297.788088476418;5302.602304827076;5311.5485183758265;5192.3769147702515;5195.558377537952;5203.323567936144;5208.192730126836;5208.53123218897 06:27:52 INFO - PROCESS | 12537 | |5;yui.html;663.7842701122137;665.0523004718278;670.8289386206517;686.6772616870072;691.5677701436603;11682;11746;11794.646160615173;11844.526218951252;11846.822297665542;10641.733956651087;11862.703432414193;12100;12107.455164517596;12130.272183668985;643.4016364780751;788.7830846517196;812.7846120777998;815.135955886759;819.8688209886419;815.8613035783931;822.198356602314;822.3667775812621;822.8930239068912;822.9135940726227;857.2756021162139;860.1484530315006;860.3547339495378;860.4364141487305;860.6944534690189;667.903154042666;832.2883934236202;853.1638993786094;853.4196746212573;858.9012263589642;625.0967352176108;625.7278084033414;626.151564629929;626.4800215820858;627.2629660149306;12404.317762523058;12463.189892656948;12470.875291247063;12486.188397754117;12497.437615307334;12187.817182742267;12416.317102559356;12625.926796222333;12756.234625922474;12912.806307905388;9089.954550227272;9107.225885799715;9176.357654964155;9206.815863682688;9505.857412138823;2839.858007099637;2891.089306868351;2899.6375453068367;2917.7957542972;2923.0646193218176;45127.09745805065;45151.322730159074;45184.548154518365;45216.32175517337;45219.3217101747;9391.483468409304;9418.481983490974;9960.651377201762;10006.79986400268;10035.849462258071;17093.145342733063;17294.52996495312;17321.7401738974;17340.65318693619;17343.65312693739;6092.3603021682975;6221.657808820558;6253.343398943137;6270.717817698214;6336.271328797156;3230.3054843208824;3259.4133056049664;3281.0812972367776;3298.2578919742864;3406.710429613461;2685.2481305234564;2774.209350335145;2780.193743814312;2780.555111182201;2781.9443611127663;477.24356894322193;494.82433736023916;500.07236576151445;501.3157040639501;507.41393690287777;504.80060376151215;580.6312991250502;588.2558563417281;588.790979202377;595.6694034810722;7267.491275610657;7285.198628150899;7572.7728168155045;7667.501612395176;7849.725259615886;540.1573545269392;546;549.6207616744433;551.7131091832225;554.5092593055094;3409.931801363959;3992.9635885698503;4187.099773548641;4215.346621273708;4312.762798046075;51898.48101518936;52273.7386313066;52459;52484.47515524872;55225;44586.33120503195;45094.32358514625;45243.32135017977;46198.30702539397;47243.763781180875;42531.7873410631;42542;42901.57098429038;43548.12903741907;43987.12025759531;8192.426530143071;8231;8310.70912518059;8406.495610263404;8644.78388040304;29047.854760726063;29393.412131757672;29836.104916852528;29956.700432995392;30032.84983575068;36401.635983639826;37822;38201.61798381981;38481.23037539289;38921.221575568896;10536.103501369827;10650.573977041142;10682.73293167677;10705.19711021661;10907;11342.092632589538;11452.312861228353;11463;11568.074554035826;12163.81754273669;10770.353778773298;11039.668809935714;11125.443727813416;11404.48679809394;11491.138164637518;10260.897391025994;10336.948315258676;10432.008959148869;10779.514921828693;10803.783924321313;10033.297669163088;10164.898351016394;10372.688819335432;10687.46562671879;10723.89276107229;9141.497217653094;9348.859767103362;9819.263555233529;9848.950755246178;9924.900750992687;9451.338406311492;9474.905250947402;9528;9533.666321678707;9537.284703647116 06:27:52 INFO - PROCESS | 12537 | __end_tp_report 06:27:52 INFO - PROCESS | 12537 | __start_cc_report 06:27:52 INFO - PROCESS | 12537 | _x_x_mozilla_cycle_collect,1148 06:27:52 INFO - PROCESS | 12537 | __end_cc_report 06:27:52 INFO - PROCESS | 12537 | __startTimestamp1461331672514__endTimestamp 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | ------- Summary: start ------- 06:27:52 INFO - PROCESS | 12537 | Number of tests: 6 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#0] dojo.html Cycles:165 Average:4551.32 Median:4650.42 stddev:451.34 (9.7%) stddev-sans-first:425.78 06:27:52 INFO - PROCESS | 12537 | Values: 2593.2 2658.1 2666.5 2678.3 2692.5 4484.8 4560.5 4606.0 4616.9 4623.5 4596.5 4604.8 4621.4 4677.5 4692.4 4201.3 4218.5 4263.8 4290.7 4372.5 4346.1 4367.0 4383.5 4390.6 4412.3 4162.6 4203.3 4229.7 4292.3 4309.4 4214.6 4254.1 4267.9 4268.0 4307.8 4189.7 4189.8 4190.2 4218.9 4223.9 4323.2 4431.5 4456.2 4497.6 4561.7 4898.6 4902.5 4910.2 4912.9 4962.8 4903.3 4914.8 4925.6 4944.8 4956.0 4481.8 4553.8 4614.1 4647.8 4648.6 5061.0 5061.6 5072.7 5075.8 5076.3 4868.1 4872.7 4875.5 4889.3 4947.4 4762.2 4892.1 4934.6 4969.7 4974.6 4818.1 4833.1 4840.5 4859.1 4910.6 4663.1 4821.3 4831.4 4849.3 4895.8 4140.5 4196.7 4203.4 4204.3 4216.9 3667.6 3696.0 3700.4 3711.9 3726.0 4260.0 4283.9 4288.8 4296.9 4316.7 4813.8 4879.1 4938.4 4956.4 4959.3 4261.2 4276.1 4295.3 4299.9 4337.9 4464.2 4500.3 4502.5 4545.8 4548.5 4515.7 4695.9 4723.9 4767.6 4779.9 4879.2 4887.9 4907.0 4925.8 4956.7 4600.8 4650.4 4670.6 4679.1 4717.4 4827.8 4831.6 4841.5 4892.8 4899.1 4835.9 4842.8 4860.0 4861.3 4915.0 4613.6 4732.7 4734.5 4777.2 4791.6 4757.3 4776.7 4780.1 4781.4 4818.3 4699.6 4703.7 4710.0 4741.4 4746.9 4649.7 4776.4 4820.7 4850.4 4862.8 4571.0 4631.7 4643.6 4648.1 4648.6 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#1] ext.html Cycles:180 Average:44500.91 Median:33376.50 stddev:77532.11 (232.3%) stddev-sans-first:77679.44 06:27:52 INFO - PROCESS | 12537 | Values: 570.7 588.4 589.2 597.4 612.8 28614.3 33819.8 34937.5 34968.0 35104.8 40128.0 41094.0 41311.0 41385.6 41387.2 7261.3 7443.0 7443.5 7695.3 7944.9 7350.0 9604.8 9952.2 9974.8 10036.1 9957.3 10077.4 10084.0 10084.6 10086.0 7437.6 7739.9 9888.4 9991.1 10004.0 7342.6 9378.1 9599.5 9602.2 9603.5 34479.7 34998.8 35108.8 35184.5 35251.5 3012.0 3030.7 3049.3 3123.9 3237.4 29277.9 29495.4 29769.7 29786.4 29810.7 3308.9 3346.9 3384.4 3408.7 3444.6 239016.0 239164.0 242809.0 243046.0 243076.0 56504.2 57175.1 57221.0 57261.4 57409.7 59759.4 61261.0 61414.7 61434.4 61468.8 13409.1 13567.2 13623.8 13623.8 13630.7 9545.7 10077.3 10277.0 10332.9 10456.8 18350.3 18374.6 18410.5 18422.5 18470.9 7093.2 7301.5 7364.3 7603.8 7668.2 886.5 934.9 973.7 976.0 1013.1 27144.2 28358.0 28879.9 29651.4 30360.5 990.0 998.9 1008.3 1098.2 1118.5 13845.4 14457.6 14505.1 14520.9 14644.4 357005.0 364850.0 365172.0 365537.0 367265.0 46648.5 47368.5 47518.0 47778.8 47879.0 1145.1 1213.9 1233.1 1275.3 1309.5 24597.0 26252.7 27795.9 27917.3 27924.9 38826.2 39553.4 39625.2 39718.4 39737.6 264265.0 265480.0 265704.0 266306.0 266808.0 21872.6 24120.0 25197.4 25948.6 25968.4 34925.3 35104.6 35478.0 35565.6 35679.6 30282.0 30801.4 30939.5 31099.5 31331.7 31508.0 33017.3 33218.8 33365.7 33531.2 32784.3 33387.3 33655.3 33742.3 33837.7 30046.0 30323.0 30415.8 30420.2 30480.5 23538.2 23779.8 23974.6 24002.4 24318.5 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#2] jquery.html Cycles:180 Average:23626.71 Median:4716.59 stddev:63291.32 (1341.9%) stddev-sans-first:63444.79 06:27:52 INFO - PROCESS | 12537 | Values: 376.2 376.6 382.3 384.6 388.4 15750.1 15753.8 16766.3 16774.2 16782.4 9976.5 10747.7 10766.4 10781.3 10786.6 4714.2 4856.8 4888.2 4892.2 4916.0 4686.4 4822.3 4831.8 4835.2 4844.9 4786.9 4825.0 4832.5 4837.6 4853.1 4706.0 4784.2 4834.8 4877.8 4877.8 4465.5 4709.1 4719.0 4724.7 4731.2 19024.0 19622.0 19821.0 19856.3 19948.5 1849.5 1878.3 1912.1 1929.4 1959.3 8856.2 9201.7 9466.6 9486.5 9536.9 1707.6 1755.4 1803.5 1833.8 1848.3 66023.7 66075.0 66259.3 66297.7 67364.7 9769.7 9771.0 9788.3 9888.9 9937.6 13517.9 13612.2 13640.8 13644.2 13648.1 6738.2 6826.8 6856.0 6932.5 6958.3 6227.6 6315.7 6428.6 6458.0 6465.7 4184.8 4266.5 4273.0 4380.1 4388.1 1785.9 1854.9 1876.2 1878.0 1892.4 792.6 851.3 852.5 887.9 928.9 16103.2 16392.4 16605.7 16629.3 17121.7 874.4 878.7 897.4 926.2 933.6 9084.6 9562.9 9591.4 9645.2 9710.0 376123.0 379476.4 384148.0 386832.0 387767.0 78098.2 79019.6 79121.0 79311.6 80190.0 934.6 967.2 973.4 992.0 994.7 15219.2 15259.2 15384.3 15535.0 15956.7 32907.0 33564.2 34115.3 34327.0 34684.3 48371.3 49219.0 49516.0 49551.5 49574.3 7768.6 7956.3 7978.0 7989.3 8074.7 8509.0 11247.9 11320.3 11640.8 11863.9 9919.4 10197.5 10328.2 10383.9 10589.8 10065.1 10201.9 10351.9 10378.6 10381.6 10241.4 10273.2 10406.7 10478.6 10768.4 7554.6 7721.7 7871.4 7949.4 8140.2 9007.0 10216.2 10468.2 10490.3 10501.9 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#3] mootools.html Cycles:180 Average:5167.53 Median:4792.54 stddev:2849.83 (59.5%) stddev-sans-first:2842.83 06:27:52 INFO - PROCESS | 12537 | Values: 1279.0 1442.6 1458.1 1603.6 1775.6 6760.7 7438.8 7625.2 7634.0 7647.5 7458.2 7626.5 7633.2 7640.7 7647.6 2169.0 2183.8 2191.5 2202.4 2203.6 2200.9 2225.9 2245.4 2246.1 2250.5 2210.5 2227.7 2237.6 2239.5 2250.3 2142.1 2166.6 2170.5 2179.8 2180.0 2138.8 2150.7 2151.4 2152.7 2156.8 7644.8 7713.1 7748.9 7767.5 7777.6 4613.2 4729.3 4732.8 4768.2 4771.4 2973.6 3003.7 3046.1 3054.1 3070.8 937.3 944.9 952.0 958.9 960.9 9757.4 10011.2 10036.2 10064.8 10073.0 3901.7 4029.9 4150.5 4161.4 4175.7 8088.6 8139.0 8146.5 8154.3 8177.0 4582.5 4592.7 4594.7 4616.3 4629.3 3739.4 4213.0 4304.1 4316.2 4384.9 3503.7 3522.0 3546.4 3586.5 3617.2 1104.1 1118.0 1119.4 1119.7 1142.5 768.8 877.7 892.7 923.1 929.7 5590.8 5603.8 5772.4 5794.2 5896.0 915.0 916.6 932.6 936.1 944.9 3857.3 3859.7 3886.5 3949.1 4122.9 9765.7 10089.3 10176.4 10198.9 10211.6 10101.9 10110.3 10120.5 10120.8 10131.6 6983.3 7246.7 7255.9 7411.3 7450.8 5572.1 5639.9 5770.8 5811.6 5848.5 8896.6 9125.4 9154.5 9220.1 9365.1 9200.3 9275.0 9291.0 9358.7 9457.9 5904.5 6043.8 6513.3 6848.7 6964.4 7398.0 7426.2 7510.1 7526.3 7529.0 6652.1 6723.7 6812.0 6828.8 6966.2 6745.3 6783.8 6805.5 6821.9 6828.4 6247.6 6368.2 6422.9 6428.5 6432.9 4542.2 4563.3 4605.8 4647.0 4648.1 4636.4 4694.0 4784.7 4800.4 4834.9 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#4] prototype.html Cycles:180 Average:4378.12 Median:4973.72 stddev:1255.23 (25.2%) stddev-sans-first:1220.96 06:27:52 INFO - PROCESS | 12537 | Values: 305.3 316.7 322.0 322.6 325.8 4958.6 4981.9 5052.8 5059.2 5079.4 4694.2 4767.2 4849.3 4965.5 5004.4 3958.6 3989.2 3996.6 3997.8 4010.2 3990.1 3994.0 3998.0 4009.9 4011.4 3704.8 3808.0 3937.7 3952.7 3965.6 3929.0 3937.4 3944.1 3952.8 3963.3 3507.3 3510.9 3513.3 3516.3 3522.3 4688.7 4761.3 4792.7 4798.2 4799.7 4487.6 4514.2 4515.9 4531.4 4536.5 5210.1 5221.8 5234.3 5236.2 5241.2 3731.5 3774.8 3826.9 3833.9 3836.2 5480.2 5489.6 5492.7 5499.9 5501.8 3893.7 3907.7 3913.3 3914.4 3920.3 3964.9 3975.4 3978.1 3979.3 3981.0 4361.5 4469.7 4474.8 4478.5 4501.5 5194.2 5201.2 5216.3 5222.1 5225.2 1293.5 1340.2 1373.1 1390.4 1392.4 942.4 958.1 967.7 970.2 975.4 4543.4 4544.3 4556.0 4572.2 4598.2 5332.9 5357.3 5366.8 5367.4 5372.1 4441.2 4580.3 4598.4 4601.1 4602.6 2841.8 2875.3 2883.4 2891.7 2903.6 5124.5 5125.2 5130.7 5137.9 5143.7 5311.3 5507.6 5517.8 5529.2 5627.2 5164.6 5187.7 5194.7 5196.6 5202.2 5455.8 5462.5 5467.5 5476.0 5476.4 5255.9 5360.0 5363.2 5377.4 5381.9 5159.5 5164.6 5177.4 5196.9 5199.3 3752.2 3779.7 3794.1 3796.3 3797.3 5189.5 5236.3 5432.9 5435.8 5442.8 5075.2 5238.5 5252.1 5255.6 5270.9 5238.8 5257.3 5265.5 5265.5 5286.7 4896.1 5128.5 5168.2 5173.5 5205.9 5274.7 5286.9 5297.8 5302.6 5311.5 5192.4 5195.6 5203.3 5208.2 5208.5 06:27:52 INFO - PROCESS | 12537 | 06:27:52 INFO - PROCESS | 12537 | [#5] yui.html Cycles:180 Average:12613.32 Median:45167.94 stddev:14411.97 (31.9%) stddev-sans-first:14424.46 06:27:52 INFO - PROCESS | 12537 | Values: 663.8 665.1 670.8 686.7 691.6 11682.0 11746.0 11794.6 11844.5 11846.8 10641.7 11862.7 12100.0 12107.5 12130.3 643.4 788.8 812.8 815.1 819.9 815.9 822.2 822.4 822.9 822.9 857.3 860.1 860.4 860.4 860.7 667.9 832.3 853.2 853.4 858.9 625.1 625.7 626.2 626.5 627.3 12404.3 12463.2 12470.9 12486.2 12497.4 12187.8 12416.3 12625.9 12756.2 12912.8 9090.0 9107.2 9176.4 9206.8 9505.9 2839.9 2891.1 2899.6 2917.8 2923.1 45127.1 45151.3 45184.5 45216.3 45219.3 9391.5 9418.5 9960.7 10006.8 10035.8 17093.1 17294.5 17321.7 17340.7 17343.7 6092.4 6221.7 6253.3 6270.7 6336.3 3230.3 3259.4 3281.1 3298.3 3406.7 2685.2 2774.2 2780.2 2780.6 2781.9 477.2 494.8 500.1 501.3 507.4 504.8 580.6 588.3 588.8 595.7 7267.5 7285.2 7572.8 7667.5 7849.7 540.2 546.0 549.6 551.7 554.5 3409.9 3993.0 4187.1 4215.3 4312.8 51898.5 52273.7 52459.0 52484.5 55225.0 44586.3 45094.3 45243.3 46198.3 47243.8 42531.8 42542.0 42901.6 43548.1 43987.1 8192.4 8231.0 8310.7 8406.5 8644.8 29047.9 29393.4 29836.1 29956.7 30032.8 36401.6 37822.0 38201.6 38481.2 38921.2 10536.1 10650.6 10682.7 10705.2 10907.0 11342.1 11452.3 11463.0 11568.1 12163.8 10770.4 11039.7 11125.4 11404.5 11491.1 10260.9 10336.9 10432.0 10779.5 10803.8 10033.3 10164.9 10372.7 10687.5 10723.9 9141.5 9348.9 9819.3 9849.0 9924.9 9451.3 9474.9 9528.0 9533.7 9537.3 06:27:52 INFO - PROCESS | 12537 | -------- Summary: end -------- 06:27:52 INFO - PROCESS | 12537 | 06:27:53 INFO - TEST-INFO | 12537: exit 0 06:27:53 INFO - TEST-OK | dromaeo_css | took 1118254ms 06:27:53 INFO - TEST-START | kraken 06:27:53 INFO - operating with platform_type : linux_ 06:27:53 INFO - Initialising browser for kraken test... 06:27:53 INFO - TEST-INFO | started process 12719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnuUMG7/profile http://localhost:37790/getInfo.html) 06:27:57 INFO - PROCESS | 12719 | __metrics Screen width/height:1600/1200 06:27:57 INFO - PROCESS | 12719 | colorDepth:24 06:27:57 INFO - PROCESS | 12719 | Browser inner width/height: 1024/697 06:27:57 INFO - PROCESS | 12719 | __metrics 06:27:58 ERROR - PROCESS | 12719 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:27:59 INFO - TEST-INFO | 12719: exit 0 06:27:59 INFO - Browser initialized. 06:27:59 INFO - Running cycle 1/1 for kraken test... 06:27:59 INFO - TEST-INFO | started process 12800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnuUMG7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:11 INFO - PROCESS | 12800 | RSS: Main: 155099136 06:28:11 INFO - PROCESS | 12800 | 06:28:13 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37790/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:14 INFO - PROCESS | 12800 | RSS: Main: 209567744 06:28:14 INFO - PROCESS | 12800 | 06:28:17 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37790/tests/kraken/driver.html?testName=audio-dft) 06:28:18 INFO - PROCESS | 12800 | RSS: Main: 194899968 06:28:18 INFO - PROCESS | 12800 | 06:28:21 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37790/tests/kraken/driver.html?testName=audio-fft) 06:28:22 INFO - PROCESS | 12800 | RSS: Main: 267120640 06:28:22 INFO - PROCESS | 12800 | 06:28:24 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37790/tests/kraken/driver.html?testName=audio-oscillator) 06:28:24 INFO - PROCESS | 12800 | RSS: Main: 175112192 06:28:24 INFO - PROCESS | 12800 | 06:28:27 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37790/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:27 INFO - PROCESS | 12800 | RSS: Main: 179163136 06:28:27 INFO - PROCESS | 12800 | 06:28:30 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37790/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:31 INFO - PROCESS | 12800 | RSS: Main: 215015424 06:28:31 INFO - PROCESS | 12800 | 06:28:34 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37790/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:35 INFO - PROCESS | 12800 | RSS: Main: 215834624 06:28:35 INFO - PROCESS | 12800 | 06:28:38 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37790/tests/kraken/driver.html?testName=json-parse-financial) 06:28:39 INFO - PROCESS | 12800 | RSS: Main: 216244224 06:28:39 INFO - PROCESS | 12800 | 06:28:40 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37790/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:41 INFO - PROCESS | 12800 | RSS: Main: 201084928 06:28:41 INFO - PROCESS | 12800 | 06:28:43 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:43 INFO - PROCESS | 12800 | RSS: Main: 206761984 06:28:43 INFO - PROCESS | 12800 | 06:28:45 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:46 INFO - PROCESS | 12800 | RSS: Main: 221110272 06:28:46 INFO - PROCESS | 12800 | 06:28:49 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:50 INFO - PROCESS | 12800 | RSS: Main: 224858112 06:28:50 INFO - PROCESS | 12800 | 06:28:53 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:28:53 INFO - PROCESS | 12800 | RSS: Main: 218140672 06:28:53 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | Cycle 1(1): loaded http://localhost:37790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37790/tests/kraken/driver.html?testName=ai-astar) 06:28:55 INFO - PROCESS | 12800 | RSS: Main: 281378816 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | __start_tp_report 06:28:55 INFO - PROCESS | 12800 | _x_x_mozilla_page_load 06:28:55 INFO - PROCESS | 12800 | _x_x_mozilla_page_load_details 06:28:55 INFO - PROCESS | 12800 | |i|pagename|runs| 06:28:55 INFO - PROCESS | 12800 | |0;ai-astar;113;114;108;112;113;112;102;113;113;113 06:28:55 INFO - PROCESS | 12800 | |1;audio-beat-detection;172;136;158;190;133;156;165;137;194;140 06:28:55 INFO - PROCESS | 12800 | |2;audio-dft;162;162;162;162;162;161;161;162;165;163 06:28:55 INFO - PROCESS | 12800 | |3;audio-fft;73;74;114;108;73;73;72;117;103;84 06:28:55 INFO - PROCESS | 12800 | |4;audio-oscillator;96;101;148;95;93;94;144;94;94;155 06:28:55 INFO - PROCESS | 12800 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 06:28:55 INFO - PROCESS | 12800 | |6;imaging-darkroom;146;145;146;146;145;145;147;145;146;147 06:28:55 INFO - PROCESS | 12800 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;94 06:28:55 INFO - PROCESS | 12800 | |8;json-parse-financial;65;72;65;64;65;66;65;89;63;62 06:28:55 INFO - PROCESS | 12800 | |9;json-stringify-tinderbox;64;65;65;65;65;64;65;64;64;64 06:28:55 INFO - PROCESS | 12800 | |10;stanford-crypto-aes;87;79;78;78;79;88;81;80;81;80 06:28:55 INFO - PROCESS | 12800 | |11;stanford-crypto-ccm;135;134;144;141;132;132;138;136;170;138 06:28:55 INFO - PROCESS | 12800 | |12;stanford-crypto-pbkdf2;177;173;177;182;172;171;174;171;173;171 06:28:55 INFO - PROCESS | 12800 | |13;stanford-crypto-sha256-iterative;74;74;71;73;73;74;72;73;72;72 06:28:55 INFO - PROCESS | 12800 | __end_tp_report 06:28:55 INFO - PROCESS | 12800 | __start_cc_report 06:28:55 INFO - PROCESS | 12800 | _x_x_mozilla_cycle_collect,1897 06:28:55 INFO - PROCESS | 12800 | __end_cc_report 06:28:55 INFO - PROCESS | 12800 | __startTimestamp1461331735686__endTimestamp 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | ------- Summary: start ------- 06:28:55 INFO - PROCESS | 12800 | Number of tests: 14 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:3.82 06:28:55 INFO - PROCESS | 12800 | Values: 113.0 114.0 108.0 112.0 113.0 112.0 102.0 113.0 113.0 113.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:161.50 stddev:22.22 (13.8%) stddev-sans-first:22.99 06:28:55 INFO - PROCESS | 12800 | Values: 172.0 136.0 158.0 190.0 133.0 156.0 165.0 137.0 194.0 140.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 06:28:55 INFO - PROCESS | 12800 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 161.0 162.0 165.0 163.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:19.07 (26.1%) stddev-sans-first:19.32 06:28:55 INFO - PROCESS | 12800 | Values: 73.0 74.0 114.0 108.0 73.0 73.0 72.0 117.0 103.0 84.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:94.00 stddev:26.17 (27.8%) stddev-sans-first:27.16 06:28:55 INFO - PROCESS | 12800 | Values: 96.0 101.0 148.0 95.0 93.0 94.0 144.0 94.0 94.0 155.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:28:55 INFO - PROCESS | 12800 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:28:55 INFO - PROCESS | 12800 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 147.0 145.0 146.0 147.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:28:55 INFO - PROCESS | 12800 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:65.00 stddev:7.97 (12.3%) stddev-sans-first:8.40 06:28:55 INFO - PROCESS | 12800 | Values: 65.0 72.0 65.0 64.0 65.0 66.0 65.0 89.0 63.0 62.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 06:28:55 INFO - PROCESS | 12800 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:3.54 (4.4%) stddev-sans-first:3.05 06:28:55 INFO - PROCESS | 12800 | Values: 87.0 79.0 78.0 78.0 79.0 88.0 81.0 80.0 81.0 80.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:138.00 stddev:11.21 (8.1%) stddev-sans-first:11.74 06:28:55 INFO - PROCESS | 12800 | Values: 135.0 134.0 144.0 141.0 132.0 132.0 138.0 136.0 170.0 138.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:173.50 stddev:3.57 (2.1%) stddev-sans-first:3.63 06:28:55 INFO - PROCESS | 12800 | Values: 177.0 173.0 177.0 182.0 172.0 171.0 174.0 171.0 173.0 171.0 06:28:55 INFO - PROCESS | 12800 | 06:28:55 INFO - PROCESS | 12800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.03 (1.4%) stddev-sans-first:1.00 06:28:55 INFO - PROCESS | 12800 | Values: 74.0 74.0 71.0 73.0 73.0 74.0 72.0 73.0 72.0 72.0 06:28:55 INFO - PROCESS | 12800 | -------- Summary: end -------- 06:28:55 INFO - PROCESS | 12800 | 06:28:56 INFO - TEST-INFO | 12800: exit 0 06:28:56 INFO - TEST-OK | kraken | took 63516ms 06:28:56 INFO - SUITE-END | took 1181s 06:28:56 INFO - Completed test suite (00:19:41) 06:28:56 INFO - javascript benchmark 06:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.1572239022316, 2658.082961378324, 2666.5066962611904, 2678.2500899748065, 2692.461507698461, 4484.753338566377, 4560.475545312282, 4605.953940460595, 4616.907661846765, 4623.514530974246, 4596.517365676606, 4604.792784324705, 4621.353010578513, 4677.4854765975715, 4692.389989301386, 4201.264778663737, 4218.472690913643, 4263.829446822124, 4290.699651024414, 4372.453443319585, 4346.130773845228, 4366.978165109186, 4383.517813040563, 4390.5609439056, 4412.338149277618, 4162.625363717265, 4203.327467605169, 4229.70392072555, 4292.313229883203, 4309.396684464177, 4214.641755450791, 4254.149170165979, 4267.893302667427, 4267.997020700133, 4307.82768689252, 4189.706720529564, 4189.790510474494, 4190.245755763961, 4218.91562168758, 4223.87328380146, 4323.156984388045, 4431.512533621299, 4456.153330867125, 4497.550244975509, 4561.7491037992895, 4898.559129678346, 4902.460729319772, 4910.165271903785, 4912.901741965176, 4962.801487940478, 4903.338049363326, 4914.827981020647, 4925.605951523869, 4944.8269310574315, 4955.950440495585, 4481.753503557303, 4553.772311384418, 4614.146382919171, 4647.814087436533, 4648.581627653527, 5061.0, 5061.620378471629, 5072.721000344943, 5075.847724568269, 5076.314697515862, 4868.123737727243, 4872.731999740048, 4875.536824001714, 4889.315495830587, 4947.406311242602, 4762.190427627312, 4892.094962431962, 4934.55588996992, 4969.676970996946, 4974.577160941288, 4818.10864989978, 4833.081714474239, 4840.491748366441, 4859.125357435625, 4910.607151427877, 4663.090697314059, 4821.349117869113, 4831.371921650233, 4849.345338379344, 4895.828645997373, 4140.4617399737845, 4196.664266858705, 4203.390508376268, 4204.348326009474, 4216.936745948813, 3667.6149004354693, 3696.039029852258, 3700.4264339027495, 3711.9443208351895, 3726.0, 4260.0, 4283.850065247763, 4288.8284468620905, 4296.892577685583, 4316.740995540277, 4813.831515896927, 4879.1461494238365, 4938.38270216223, 4956.3804524434445, 4959.256111583291, 4261.21167583998, 4276.102018576134, 4295.334223195409, 4299.914001720011, 4337.869863904088, 4464.241079016575, 4500.257457519538, 4502.5047244803045, 4545.818167273272, 4548.47692515365, 4515.68390212682, 4695.929561056655, 4723.929141062956, 4767.61859051282, 4779.904401912012, 4879.170541008109, 4887.902241955212, 4906.95093049065, 4925.778339974638, 4956.702597844141, 4600.769961501845, 4650.4186976627925, 4670.556297151765, 4679.110968915895, 4717.43390793107, 4827.782749776198, 4831.565159135695, 4841.515848415131, 4892.779824907959, 4899.11815873132, 4835.854924352275, 4842.782074806712, 4860.0, 4861.343718597944, 4915.0, 4613.607843333354, 4732.716037037789, 4734.526547345238, 4777.235642297216, 4791.616670666269, 4757.33397324368, 4776.713397196179, 4780.067886762048, 4781.402324709411, 4818.325434439112, 4699.577038066591, 4703.670743047954, 4710.034442939258, 4741.407324084489, 4746.905061898674, 4649.721016739007, 4776.355192049029, 4820.734859582757, 4850.369451971221, 4862.756862156807, 4571.0, 4631.745254010927, 4643.558861908114, 4648.140094082605, 4648.604868586208], "value": 4524.325072382792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6804189653794, 588.396893184486, 589.1722130406778, 597.4055814464608, 612.770211170811, 28614.284642883937, 33819.83090084549, 34937.47593786095, 34968.0, 35104.82447587758, 40128.0, 41094.0, 41311.0, 41385.58614413855, 41387.17225655485, 7261.3101755333155, 7442.962785186067, 7443.516171448866, 7695.307422331989, 7944.920550794476, 7349.963250183741, 9604.807903841918, 9952.203823694088, 9974.800503989916, 10036.14692751117, 9957.302988790787, 10077.44574048427, 10084.0, 10084.647037353694, 10086.0, 7437.590932498711, 7739.922600774033, 9888.40669559825, 9991.100800927916, 10004.0, 7342.632868356561, 9378.109079637423, 9599.4720290384, 9602.183814375787, 9603.519824008841, 34479.655203447895, 34998.825005875064, 35108.824455877555, 35184.47223291652, 35251.4712279316, 3012.0361484325026, 3030.6666266710645, 3049.283418396675, 3123.9219019524467, 3237.3848968695875, 29277.85361073202, 29495.410091798043, 29769.702302976908, 29786.404271914656, 29810.70189298101, 3308.9172770680925, 3346.949795753041, 3384.4415671414185, 3408.659134086596, 3444.5522082129164, 239016.0, 239164.0, 242809.0, 243046.0, 243076.0, 56504.15243771347, 57175.14237286444, 57221.0, 57261.42738572561, 57409.71295143581, 59759.40240597625, 61261.0, 61414.692926535085, 61434.38565614287, 61468.77062458815, 13409.128406653535, 13567.1859688419, 13623.795643065361, 13623.795643065361, 13630.727385452434, 9545.665901693408, 10077.29458937882, 10277.0, 10332.948335258427, 10456.790864182674, 18350.26598936054, 18374.63250734978, 18410.539736506427, 18422.539436513925, 18470.907645461688, 7093.219745827955, 7301.452391070691, 7364.3372096511575, 7603.809904752315, 7668.233176682287, 886.4636894678755, 934.8644446555347, 973.6932866147141, 975.9658411955547, 1013.108464551205, 27144.1856744298, 28358.0, 28879.85560072186, 29651.40697186044, 30360.54459183114, 989.980200395988, 998.9300748947504, 1008.3093081239374, 1098.242212873115, 1118.4854966715402, 13845.446182152802, 14457.566273011826, 14505.095768727337, 14520.927395362956, 14644.414223431157, 357005.0, 364850.0, 365172.0, 365537.0, 367265.0, 46648.5335146651, 47368.52631473641, 47518.0, 47778.761106194244, 47879.0, 1145.0896537252904, 1213.854337479508, 1233.1491271022965, 1275.2858399296424, 1309.4892991733423, 24597.0, 26252.73747262503, 27795.861020694767, 27917.302067448476, 27924.860375698805, 38826.2234755309, 39553.406698900115, 39625.207495850496, 39718.40422393724, 39737.60262397455, 264265.0, 265480.0, 265704.0, 266306.0, 266808.0, 21872.562548749254, 24120.0, 25197.370065748502, 25948.610770838073, 25968.350791230372, 34925.30149397049, 35104.64895351116, 35478.0, 35565.644343557266, 35679.64320356763, 30282.0, 30801.38397231998, 30939.535906960962, 31099.533506997865, 31331.68668313379, 31508.0, 33017.33965320728, 33218.833905831285, 33365.666343336256, 33531.161720956195, 32784.34431311408, 33387.332253355286, 33655.326893461504, 33742.32515349728, 33837.66162338345, 30046.0, 30323.0, 30415.847920760254, 30420.239494012825, 30480.542791857697, 23538.176163834185, 23779.844282044534, 23974.640380393957, 24002.39994000164, 24318.513629726953], "value": 17381.322780798368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.16303724213617, 376.6026841682024, 382.32519602900885, 384.63843986652563, 388.36890053662796, 15750.13374264415, 15753.763693544606, 16766.329346826144, 16774.161291935387, 16782.412615558456, 9976.50117494126, 10747.677569672902, 10766.35401875888, 10781.299215550984, 10786.5685372585, 4714.222153344694, 4856.781444834974, 4888.242322440027, 4892.241702536113, 4915.950840491585, 4686.437627484706, 4822.300766388889, 4831.782569784368, 4835.15384807659, 4844.87887802806, 4786.904261914759, 4824.975875120619, 4832.492588278233, 4837.612990960714, 4853.053654537367, 4706.0, 4784.210605250129, 4834.7824347904425, 4877.804887804484, 4877.804887804484, 4465.531119232466, 4709.081729062834, 4718.952810471886, 4724.7401392923375, 4731.195696731564, 19024.0, 19622.0, 19821.0, 19856.30502932405, 19948.50128746793, 1849.4821449994024, 1878.2768634075842, 1912.1108684461653, 1929.4018854155117, 1959.2848610257297, 8856.158664926821, 9201.67794127209, 9466.621335146587, 9486.478243696594, 9536.904630953672, 1707.5901783571978, 1755.4470341842407, 1803.5310819187105, 1833.8074502177346, 1848.2791711232496, 66023.66988165077, 66075.0, 66259.33740662532, 66297.66851165761, 67364.6631766838, 9769.68109305249, 9770.951145244371, 9788.265880058882, 9888.901110988798, 9937.602495900228, 13517.932410337886, 13612.183269003892, 13640.795388069188, 13644.249566273751, 13648.112872663245, 6738.19141702989, 6826.829329266808, 6856.0, 6932.549384290005, 6958.269381714948, 6227.564070515111, 6315.652639104802, 6428.614283143026, 6458.0, 6465.674536719961, 4184.832606695759, 4266.466691663542, 4273.0, 4380.123975204971, 4388.05656783793, 1785.8928464292185, 1854.8887066776037, 1876.2138224736257, 1877.9624407512047, 1892.3944337811768, 792.6274650914061, 851.3317046118767, 852.5140669818144, 887.8535041718173, 928.8513837785922, 16103.194840258175, 16392.426265080663, 16605.6678866422, 16629.3348266068, 17121.743173852403, 874.4054043250524, 878.6661068793945, 897.4077109108088, 926.1525703980917, 933.5798890499302, 9084.599521653028, 9562.904370956341, 9591.42451452915, 9645.180159686364, 9709.951450242703, 376123.0, 379476.4418786702, 384148.0, 386832.0, 387767.0, 78098.2190178091, 79019.60490197512, 79121.0, 79311.60344198358, 80190.0, 934.56075644447, 967.2068903499204, 973.4062222044547, 992.0228574853763, 994.7363948553639, 15219.162946038074, 15259.160746159068, 15384.307706153473, 15535.0, 15956.680866382376, 32907.0, 33564.160895977795, 34115.31769364649, 34327.0, 34684.30631387408, 48371.27443088427, 49219.0, 49516.0, 49551.50448495613, 49574.256386153516, 7768.572728499987, 7956.283934445928, 7978.0, 7989.320907722677, 8074.717384891501, 8509.0, 11247.943760281147, 11320.320780753182, 11640.825387619361, 11863.881361186277, 9919.355241909252, 10197.490125493843, 10328.173746100445, 10383.896161038596, 10589.788204235718, 10065.144462720751, 10201.948990255001, 10351.948240258751, 10378.584856605954, 10381.584736610754, 10241.385516869012, 10273.229507787095, 10406.687799366031, 10478.580856765644, 10768.438576406534, 7554.584497852671, 7721.652525636247, 7871.370290376871, 7949.364050876032, 8140.226678465537, 9007.0, 10216.233782466494, 10468.214883883587, 10490.31812932157, 10501.9474902625], "value": 7926.578931704856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.047109903121, 1442.624917521444, 1458.0814087125113, 1603.59108427351, 1775.6093659394937, 6760.729570817168, 7438.814029649261, 7625.237476252372, 7634.00757901472, 7647.502912310702, 7458.179600243982, 7626.466147369686, 7633.160352361236, 7640.732574359885, 7647.579383133925, 2169.0022589608798, 2183.759786423492, 2191.5288213034196, 2202.3503066595313, 2203.5813195492806, 2200.8679479231296, 2225.877576733279, 2245.382519807058, 2246.1352379333994, 2250.5386395788905, 2210.5136869888597, 2227.7326720793526, 2237.5636750833596, 2239.484918468753, 2250.3024062540585, 2142.1324363632752, 2166.5775173841107, 2170.5333353329033, 2179.7711240319777, 2179.9673004905017, 2138.7968143026387, 2150.688150218225, 2151.354593621907, 2152.687860260269, 2156.8490205685607, 7644.808879777995, 7713.112992005935, 7748.922510774876, 7767.495112817649, 7777.611119444062, 4613.1696294666945, 4729.337892695025, 4732.763361831895, 4768.189407800683, 4771.427428708543, 2973.568832519294, 3003.654579723316, 3046.0709483607493, 3054.099040782952, 3070.8464576771294, 937.339175881009, 944.9433034017981, 952.0431965874252, 958.8753462049958, 960.8606752020987, 9757.414555126716, 10011.19910407173, 10036.197104231716, 10064.798704025878, 10073.0, 3901.7073719471155, 4029.8589549365634, 4150.460440142822, 4161.396597493346, 4175.68682348825, 8088.636011379502, 8138.959305203436, 8146.470479418819, 8154.266116049584, 8176.977877765279, 4582.495925448198, 4592.6555508337005, 4594.736447476904, 4616.261398176276, 4629.305604159403, 3739.420389839525, 4213.0, 4304.053108316165, 4316.223079845595, 4384.868453946387, 3503.667151620592, 3522.0, 3546.361654902142, 3586.4799604057266, 3617.2403795203304, 1104.0780947908586, 1118.0273162348647, 1119.4346854838254, 1119.7200699825044, 1142.5030111901349, 768.815484283779, 877.7366789962986, 892.683097500391, 923.1184219070906, 929.6606738540384, 5590.776368945197, 5603.80386686464, 5772.422757724194, 5794.21778059965, 5895.970520147458, 914.995425022884, 916.5966974531318, 932.6036434515304, 936.1200471556715, 944.8960614332418, 3857.3056849767313, 3859.671927886161, 3886.4753258309765, 3949.0917089069676, 4122.9381559276635, 9765.707028789147, 10089.293749437616, 10176.389416635026, 10198.949005254926, 10211.642592509226, 10101.898981010243, 10110.292279540361, 10120.544575494121, 10120.848187277197, 10131.594736210616, 6983.301669832976, 7246.746363877133, 7255.854882902418, 7411.332980031823, 7450.776476705708, 5572.080606699849, 5639.943600563942, 5770.826875193751, 5811.622244554091, 5848.5028772553105, 8896.555172241233, 9125.406848554823, 9154.450732956044, 9220.124088211609, 9365.11031452011, 9200.263978881807, 9275.0, 9290.95354523223, 9358.719238422858, 9457.905420945703, 5904.527637789052, 6043.758249669964, 6513.2835388108215, 6848.7260509579055, 6964.373206411447, 7397.963010184914, 7426.220246874216, 7510.098788145239, 7526.285002924714, 7529.0, 6652.10196623469, 6723.697433615597, 6811.965940170466, 6828.795136145924, 6966.198887127843, 6745.325467453215, 6783.762568310085, 6805.455563555002, 6821.897671534832, 6828.351306625863, 6247.562670613013, 6368.203974503187, 6422.871542569216, 6428.517861160338, 6432.871342573216, 4542.1824071667415, 4563.269876819693, 4605.792739326671, 4646.953530464652, 4648.1168577970075, 4636.420447444069, 4693.9765301173275, 4784.6889952153, 4800.399950006249, 4834.903301934012], "value": 4186.007056123232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.34503490013935, 316.70704598246624, 321.9694129057739, 322.62414287355233, 325.83708145927034, 4958.553730164284, 4981.900361992758, 5052.823151189709, 5059.190529515278, 5079.3904731432185, 4694.225452800284, 4767.2134097873895, 4849.272609108635, 4965.535167125698, 5004.399472063348, 3958.6239307265764, 3989.1822176453757, 3996.6003399660094, 3997.7601343919314, 4010.1578668479656, 3990.08228107534, 3994.0, 3997.98001009996, 4009.939850902239, 4011.3782363733667, 3704.7591906526122, 3807.9809600952094, 3937.6849852011915, 3952.7035472339544, 3965.5637879833193, 3928.960710392888, 3937.4093885917055, 3944.1322908959983, 3952.8221230044574, 3963.3049526321947, 3507.3336066147604, 3510.877119300838, 3513.332466831294, 3516.2791627716256, 3522.277933023724, 4688.718676879398, 4761.285937062655, 4792.7124372537755, 4798.160321943646, 4799.712017278975, 4487.551244875519, 4514.210013247669, 4515.864524064284, 4531.43357080365, 4536.500984891659, 5210.140326846066, 5221.817236396746, 5234.26720259164, 5236.162214045772, 5241.187615919539, 3731.533558305212, 3774.75464094833, 3826.8660596878976, 3833.884983450473, 3836.156045669948, 5480.232767412565, 5489.64317319373, 5492.665617112751, 5499.945000549983, 5501.752421141058, 3893.6885049196, 3907.7069219808627, 3913.25648126855, 3914.432407300925, 3920.2747491713553, 3964.9008774780286, 3975.4036894465485, 3978.0850404407147, 3979.3235150024566, 3981.0, 4361.476622805284, 4469.7318160910445, 4474.821007159742, 4478.507364189936, 4501.459824821042, 5194.168932970707, 5201.245819356172, 5216.321878155815, 5222.138347172674, 5225.16397376418, 1293.4761421624257, 1340.2226708509236, 1373.1349249972454, 1390.3812803302433, 1392.4291040673477, 942.4157022646003, 958.0611001218845, 967.6516454076527, 970.1947383671536, 975.4001289207087, 4543.386642803245, 4544.250198717241, 4556.0432309214775, 4572.245579479349, 4598.241290187082, 5332.946670533245, 5357.330333708286, 5366.785328586813, 5367.355917289872, 5372.113601255827, 4441.156180325728, 4580.335851301543, 4598.425196850394, 4601.079784043138, 4602.631789456836, 2841.758450531728, 2875.266806964211, 2883.3800732842537, 2891.7108289170915, 2903.637045369329, 5124.487551244845, 5125.205593133071, 5130.692158470503, 5137.8715532112, 5143.691378517301, 5311.256424100629, 5507.621440954451, 5517.806876759294, 5529.198266251451, 5627.212190293362, 5164.586833053422, 5187.714675692873, 5194.740262986836, 5196.58427325813, 5202.219667049897, 5455.754491047833, 5462.508374246337, 5467.480589344006, 5476.0, 5476.424975377688, 5255.894882102413, 5360.0, 5363.168708850135, 5377.354717433776, 5381.865453363697, 5159.458256883124, 5164.586833053271, 5177.430482646982, 5196.856691527858, 5199.324087868553, 3752.212035472472, 3779.6976241900034, 3794.0704527390967, 3796.2597293527497, 3797.278517081856, 5189.532942035235, 5236.266922630911, 5432.945670543244, 5435.782568697208, 5442.755076021509, 5075.1625981712605, 5238.5023422774775, 5252.107141785829, 5255.605829562722, 5270.89458210826, 5238.76425560843, 5257.316548848626, 5265.4997775211295, 5265.52610265078, 5286.682799032071, 4896.143174944442, 5128.512791284822, 5168.234994278194, 5173.482651734947, 5205.947940520547, 5274.657147285414, 5286.920696189637, 5297.788088476418, 5302.602304827076, 5311.5485183758265, 5192.3769147702515, 5195.558377537952, 5203.323567936144, 5208.192730126836, 5208.53123218897], "value": 3985.4046127823735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.7842701122137, 665.0523004718278, 670.8289386206517, 686.6772616870072, 691.5677701436603, 11682.0, 11746.0, 11794.646160615173, 11844.526218951252, 11846.822297665542, 10641.733956651087, 11862.703432414193, 12100.0, 12107.455164517596, 12130.272183668985, 643.4016364780751, 788.7830846517196, 812.7846120777998, 815.135955886759, 819.8688209886419, 815.8613035783931, 822.198356602314, 822.3667775812621, 822.8930239068912, 822.9135940726227, 857.2756021162139, 860.1484530315006, 860.3547339495378, 860.4364141487305, 860.6944534690189, 667.903154042666, 832.2883934236202, 853.1638993786094, 853.4196746212573, 858.9012263589642, 625.0967352176108, 625.7278084033414, 626.151564629929, 626.4800215820858, 627.2629660149306, 12404.317762523058, 12463.189892656948, 12470.875291247063, 12486.188397754117, 12497.437615307334, 12187.817182742267, 12416.317102559356, 12625.926796222333, 12756.234625922474, 12912.806307905388, 9089.954550227272, 9107.225885799715, 9176.357654964155, 9206.815863682688, 9505.857412138823, 2839.858007099637, 2891.089306868351, 2899.6375453068367, 2917.7957542972, 2923.0646193218176, 45127.09745805065, 45151.322730159074, 45184.548154518365, 45216.32175517337, 45219.3217101747, 9391.483468409304, 9418.481983490974, 9960.651377201762, 10006.79986400268, 10035.849462258071, 17093.145342733063, 17294.52996495312, 17321.7401738974, 17340.65318693619, 17343.65312693739, 6092.3603021682975, 6221.657808820558, 6253.343398943137, 6270.717817698214, 6336.271328797156, 3230.3054843208824, 3259.4133056049664, 3281.0812972367776, 3298.2578919742864, 3406.710429613461, 2685.2481305234564, 2774.209350335145, 2780.193743814312, 2780.555111182201, 2781.9443611127663, 477.24356894322193, 494.82433736023916, 500.07236576151445, 501.3157040639501, 507.41393690287777, 504.80060376151215, 580.6312991250502, 588.2558563417281, 588.790979202377, 595.6694034810722, 7267.491275610657, 7285.198628150899, 7572.7728168155045, 7667.501612395176, 7849.725259615886, 540.1573545269392, 546.0, 549.6207616744433, 551.7131091832225, 554.5092593055094, 3409.931801363959, 3992.9635885698503, 4187.099773548641, 4215.346621273708, 4312.762798046075, 51898.48101518936, 52273.7386313066, 52459.0, 52484.47515524872, 55225.0, 44586.33120503195, 45094.32358514625, 45243.32135017977, 46198.30702539397, 47243.763781180875, 42531.7873410631, 42542.0, 42901.57098429038, 43548.12903741907, 43987.12025759531, 8192.426530143071, 8231.0, 8310.70912518059, 8406.495610263404, 8644.78388040304, 29047.854760726063, 29393.412131757672, 29836.104916852528, 29956.700432995392, 30032.84983575068, 36401.635983639826, 37822.0, 38201.61798381981, 38481.23037539289, 38921.221575568896, 10536.103501369827, 10650.573977041142, 10682.73293167677, 10705.19711021661, 10907.0, 11342.092632589538, 11452.312861228353, 11463.0, 11568.074554035826, 12163.81754273669, 10770.353778773298, 11039.668809935714, 11125.443727813416, 11404.48679809394, 11491.138164637518, 10260.897391025994, 10336.948315258676, 10432.008959148869, 10779.514921828693, 10803.783924321313, 10033.297669163088, 10164.898351016394, 10372.688819335432, 10687.46562671879, 10723.89276107229, 9141.497217653094, 9348.859767103362, 9819.263555233529, 9848.950755246178, 9924.900750992687, 9451.338406311492, 9474.905250947402, 9528.0, 9533.666321678707, 9537.284703647116], "value": 5800.398188409909, "unit": "score"}], "name": "dromaeo_css", "value": 6262.532259793686, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 108.0, 112.0, 113.0, 112.0, 102.0, 113.0, 113.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 136.0, 158.0, 190.0, 133.0, 156.0, 165.0, 137.0, 194.0, 140.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 165.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 114.0, 108.0, 73.0, 73.0, 72.0, 117.0, 103.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 148.0, 95.0, 93.0, 94.0, 144.0, 94.0, 94.0, 155.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 65.0, 64.0, 65.0, 66.0, 65.0, 89.0, 63.0, 62.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 78.0, 78.0, 79.0, 88.0, 81.0, 80.0, 81.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 144.0, 141.0, 132.0, 132.0, 138.0, 136.0, 170.0, 138.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 177.0, 182.0, 172.0, 171.0, 174.0, 171.0, 173.0, 171.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 71.0, 73.0, 73.0, 74.0, 72.0, 73.0, 72.0, 72.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1589.5999999999997, "alertThreshold": 2.0}]} 06:28:56 INFO - Return code: 0 06:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:28:56 ERROR - # TBPL SUCCESS # 06:28:56 INFO - Running post-action listener: _resource_record_post_action 06:28:56 INFO - Running post-run listener: _resource_record_post_run 06:28:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 521863168; Read time: 0; Write time: 510028 06:28:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243888128; Read time: 0; Write time: 337148 06:28:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 277975040; Read time: 0; Write time: 172880 06:28:58 INFO - Running post-run listener: _upload_blobber_files 06:28:58 INFO - Blob upload gear active. 06:28:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:28:58 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 06:28:58 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'] 06:28:58 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 06:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:59 INFO - (blobuploader) - INFO - Done attempting. 06:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:00 INFO - (blobuploader) - INFO - Done attempting. 06:29:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:00 INFO - Return code: 0 06:29:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa5c48f37c4b18b3c4bad3bd6dca42e9ea3fd874fda248b4fadf72fca5b006f8af57d2fd9e2fc0af10a664fa1ddcc2664fe9bbce5d8a41286c6bb9f0c28ab5c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58aebb2358f6edd956e697a7097b5ea67667b1c18a20d18ba9d35932ebff4c7b899f84850a0fa2f6ede5c99cf3f7c58db2267886183f83e95a1a4b00e4b6b2d7"} 06:29:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:00 INFO - Contents: 06:29:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa5c48f37c4b18b3c4bad3bd6dca42e9ea3fd874fda248b4fadf72fca5b006f8af57d2fd9e2fc0af10a664fa1ddcc2664fe9bbce5d8a41286c6bb9f0c28ab5c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58aebb2358f6edd956e697a7097b5ea67667b1c18a20d18ba9d35932ebff4c7b899f84850a0fa2f6ede5c99cf3f7c58db2267886183f83e95a1a4b00e4b6b2d7"} 06:29:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:00 INFO - Copying logs to upload dir... 06:29:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.794620 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:29:00.242606) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:00.246479) ========= 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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 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/fa5c48f37c4b18b3c4bad3bd6dca42e9ea3fd874fda248b4fadf72fca5b006f8af57d2fd9e2fc0af10a664fa1ddcc2664fe9bbce5d8a41286c6bb9f0c28ab5c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58aebb2358f6edd956e697a7097b5ea67667b1c18a20d18ba9d35932ebff4c7b899f84850a0fa2f6ede5c99cf3f7c58db2267886183f83e95a1a4b00e4b6b2d7"} build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/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/fa5c48f37c4b18b3c4bad3bd6dca42e9ea3fd874fda248b4fadf72fca5b006f8af57d2fd9e2fc0af10a664fa1ddcc2664fe9bbce5d8a41286c6bb9f0c28ab5c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58aebb2358f6edd956e697a7097b5ea67667b1c18a20d18ba9d35932ebff4c7b899f84850a0fa2f6ede5c99cf3f7c58db2267886183f83e95a1a4b00e4b6b2d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:00.271219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:00.271568) ========= 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=00204705a9daa57ed339a427000001b9-1461330501.224147-155928191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:00.354840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:29:00.355169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:29:00.355453) ========= ========= Total master_lag: 0.17 =========